[23:33:52.069] New invocation is queued and will start shortly
[23:33:53.152] Starting the invocation (attempt 1)
[23:33:53.181] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/3e2c433292e6172bf8494fe684cafe36422e98d8"
[23:33:53.181] Popped gitiles commit info from properties and tags
[23:33:53.181] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[23:33:53.181] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[23:33:53.182] Buildbucket request:
{
"requestId": "8907009074286133456",
"builder": {
"project": "infra",
"bucket": "ci",
"builder": "infra-continuous-win10-64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler-dev.appspot.com",
"invocation": "8907009074286133456",
"job": "infra/infra-continuous-win10-64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/infra/infra",
"revision": "73bc2c7cff222570a0ffe81c4ce784009beb1563"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/main@73bc2c7cff222570a0ffe81c4ce784009beb1563",
"title": "73bc2c7cff222570a0ffe81c4ce784009beb1563",
"url": "https://chromium.googlesource.com/infra/infra/+/73bc2c7cff222570a0ffe81c4ce784009beb1563"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/infra/infra",
"revision": "59f4f485da81fcc62a2da54ed8f3ab0e31667890"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/main@59f4f485da81fcc62a2da54ed8f3ab0e31667890",
"title": "59f4f485da81fcc62a2da54ed8f3ab0e31667890",
"url": "https://chromium.googlesource.com/infra/infra/+/59f4f485da81fcc62a2da54ed8f3ab0e31667890"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/infra/infra",
"revision": "be4c360918bdab58e63228edb5e78ed70f1392c0"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/main@be4c360918bdab58e63228edb5e78ed70f1392c0",
"title": "be4c360918bdab58e63228edb5e78ed70f1392c0",
"url": "https://chromium.googlesource.com/infra/infra/+/be4c360918bdab58e63228edb5e78ed70f1392c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/infra/infra",
"revision": "acc34a48ea74045e39f7bd6edc68429c587dd7a6"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/main@acc34a48ea74045e39f7bd6edc68429c587dd7a6",
"title": "acc34a48ea74045e39f7bd6edc68429c587dd7a6",
"url": "https://chromium.googlesource.com/infra/infra/+/acc34a48ea74045e39f7bd6edc68429c587dd7a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/infra/infra",
"revision": "9b7733daa529d0e6e8ee1b81b1d83a2bed9bf250"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/main@9b7733daa529d0e6e8ee1b81b1d83a2bed9bf250",
"title": "9b7733daa529d0e6e8ee1b81b1d83a2bed9bf250",
"url": "https://chromium.googlesource.com/infra/infra/+/9b7733daa529d0e6e8ee1b81b1d83a2bed9bf250"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/infra/infra",
"revision": "829d92cd8f1a859a025b3f29ac338c8199bcd900"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/main@829d92cd8f1a859a025b3f29ac338c8199bcd900",
"title": "829d92cd8f1a859a025b3f29ac338c8199bcd900",
"url": "https://chromium.googlesource.com/infra/infra/+/829d92cd8f1a859a025b3f29ac338c8199bcd900"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/infra/infra",
"revision": "90f19fd3801f94f52190904b4bf9212c0a255940"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/main@90f19fd3801f94f52190904b4bf9212c0a255940",
"title": "90f19fd3801f94f52190904b4bf9212c0a255940",
"url": "https://chromium.googlesource.com/infra/infra/+/90f19fd3801f94f52190904b4bf9212c0a255940"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/infra/infra",
"revision": "3e2c433292e6172bf8494fe684cafe36422e98d8"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/main@3e2c433292e6172bf8494fe684cafe36422e98d8",
"title": "3e2c433292e6172bf8494fe684cafe36422e98d8",
"url": "https://chromium.googlesource.com/infra/infra/+/3e2c433292e6172bf8494fe684cafe36422e98d8"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "infra/infra",
"id": "3e2c433292e6172bf8494fe684cafe36422e98d8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907009074286133456"
},
{
"key": "scheduler_job_id",
"value": "infra/infra-continuous-win10-64"
},
{
"key": "user_agent",
"value": "luci-scheduler-dev"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
}
}
[23:33:54.279] Scheduled build:
{
"id": "8741579012389858241",
"builder": {
"project": "infra",
"bucket": "ci",
"builder": "infra-continuous-win10-64"
},
"number": 29600,
"createdBy": "project:infra",
"createTime": "2024-07-23T23:33:53.255993701Z",
"updateTime": "2024-07-23T23:33:53.255993701Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "infra/infra",
"id": "3e2c433292e6172bf8494fe684cafe36422e98d8",
"ref": "refs/heads/main"
}
}
}
[23:33:54.279] Task URL: https://cr-buildbucket-dev.appspot.com/build/8741579012389858241
[23:33:54.279] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:2:0) after 5m5s
[23:33:55.112] Received PubSub notification, asking Buildbucket for the build status
[23:33:55.165] Build status: SCHEDULED
[23:38:59.298] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:2:0)
[23:38:59.326] Build status: SCHEDULED
[23:38:59.326] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:4:0) after 7m55s
[23:46:54.346] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:4:0)
[23:46:54.395] Build status: SCHEDULED
[23:46:54.395] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:5:0) after 8m45s
[23:55:39.414] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:5:0)
[23:55:39.479] Build status: SCHEDULED
[23:55:39.479] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:6:0) after 2m27s
[23:58:06.496] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:6:0)
[23:58:06.532] Build status: SCHEDULED
[23:58:06.532] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:7:0) after 2m34s
[00:00:41.307] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:7:0)
[00:00:41.358] Build status: SCHEDULED
[00:00:41.359] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:8:0) after 3m35s
[00:04:16.377] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:8:0)
[00:04:16.419] Build status: SCHEDULED
[00:04:16.419] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:9:0) after 9m5s
[00:08:20.820] Received PubSub notification, asking Buildbucket for the build status
[00:08:20.842] Build status: STARTED
[00:13:21.442] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:9:0)
[00:13:21.469] Build status: STARTED
[00:13:21.469] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:11:0) after 9m41s
[00:23:02.486] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:11:0)
[00:23:02.507] Build status: STARTED
[00:23:02.507] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:8907009074286133456:12:0) after 5m46s
[00:23:07.027] Received PubSub notification, asking Buildbucket for the build status
[00:23:07.066] Build:
{
"id": "8741579012389858241",
"builder": {
"project": "infra",
"bucket": "ci",
"builder": "infra-continuous-win10-64"
},
"number": 29600,
"createdBy": "project:infra",
"createTime": "2024-07-23T23:33:53.255993701Z",
"startTime": "2024-07-24T00:08:20.562146010Z",
"endTime": "2024-07-24T00:23:06.571343310Z",
"updateTime": "2024-07-24T00:23:06.571343310Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "infra/infra",
"id": "3e2c433292e6172bf8494fe684cafe36422e98d8",
"ref": "refs/heads/main"
}
}
}
[00:23:07.066] Invocation finished in 49m15.00299463s with status SUCCEEDED