[21:36:04.981] New invocation is queued and will start shortly
[21:36:06.094] Starting the invocation (attempt 1)
[21:36:06.130] Popped buildset tag "buildset:commit/gitiles/dawn.googlesource.com/dawn/+/c744a23d77d53b8e8e7b9d5c7d7439e2622034da"
[21:36:06.131] Popped gitiles commit info from properties and tags
[21:36:06.131] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:36:06.131] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:36:06.131] Buildbucket request:
{
"requestId": "8956482428322933920",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-rel-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8956482428322933920",
"job": "dawn/win-msvc-rel-x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "15bf15d55f5f90e08c912d70be5de207cd34a80f"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@15bf15d55f5f90e08c912d70be5de207cd34a80f",
"title": "15bf15d55f5f90e08c912d70be5de207cd34a80f",
"url": "https://dawn.googlesource.com/dawn/+/15bf15d55f5f90e08c912d70be5de207cd34a80f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "098e3d8f90800a8a2f1f0a5aff054fcdb4bca146"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@098e3d8f90800a8a2f1f0a5aff054fcdb4bca146",
"title": "098e3d8f90800a8a2f1f0a5aff054fcdb4bca146",
"url": "https://dawn.googlesource.com/dawn/+/098e3d8f90800a8a2f1f0a5aff054fcdb4bca146"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "81e55754e148eb27ec835fceebac577003df8a6b"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@81e55754e148eb27ec835fceebac577003df8a6b",
"title": "81e55754e148eb27ec835fceebac577003df8a6b",
"url": "https://dawn.googlesource.com/dawn/+/81e55754e148eb27ec835fceebac577003df8a6b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "e8ea579bceafe593964e6110559925362eb80842"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@e8ea579bceafe593964e6110559925362eb80842",
"title": "e8ea579bceafe593964e6110559925362eb80842",
"url": "https://dawn.googlesource.com/dawn/+/e8ea579bceafe593964e6110559925362eb80842"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "02855b5060831b7fa2dedf1a62567a3dc0c6207b"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@02855b5060831b7fa2dedf1a62567a3dc0c6207b",
"title": "02855b5060831b7fa2dedf1a62567a3dc0c6207b",
"url": "https://dawn.googlesource.com/dawn/+/02855b5060831b7fa2dedf1a62567a3dc0c6207b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "8dd35110c28830d2d6f81145b142860d57bfc845"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@8dd35110c28830d2d6f81145b142860d57bfc845",
"title": "8dd35110c28830d2d6f81145b142860d57bfc845",
"url": "https://dawn.googlesource.com/dawn/+/8dd35110c28830d2d6f81145b142860d57bfc845"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "75326f88e64cad9bbf3e469e61ac1427fc8f43d8"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@75326f88e64cad9bbf3e469e61ac1427fc8f43d8",
"title": "75326f88e64cad9bbf3e469e61ac1427fc8f43d8",
"url": "https://dawn.googlesource.com/dawn/+/75326f88e64cad9bbf3e469e61ac1427fc8f43d8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "c744a23d77d53b8e8e7b9d5c7d7439e2622034da"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@c744a23d77d53b8e8e7b9d5c7d7439e2622034da",
"title": "c744a23d77d53b8e8e7b9d5c7d7439e2622034da",
"url": "https://dawn.googlesource.com/dawn/+/c744a23d77d53b8e8e7b9d5c7d7439e2622034da"
}
]
}
},
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "c744a23d77d53b8e8e7b9d5c7d7439e2622034da",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956482428322933920"
},
{
"key": "scheduler_job_id",
"value": "dawn/win-msvc-rel-x64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:36:06.501] Scheduled build:
{
"id": "8791052366370683217",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-rel-x64"
},
"createdBy": "project:dawn",
"createTime": "2023-01-24T21:36:06.217176469Z",
"updateTime": "2023-01-24T21:36:06.217176469Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "c744a23d77d53b8e8e7b9d5c7d7439e2622034da",
"ref": "refs/heads/main"
}
}
}
[21:36:06.501] Task URL: https://cr-buildbucket.appspot.com/build/8791052366370683217
[21:36:06.502] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:2:0) after 5m9s
[21:41:17.212] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:2:0)
[21:41:17.245] Build status: SCHEDULED
[21:41:17.245] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:3:0) after 1m48s
[21:43:05.255] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:3:0)
[21:43:05.296] Build status: SCHEDULED
[21:43:05.296] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:4:0) after 1m14s
[21:44:19.312] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:4:0)
[21:44:19.338] Build status: SCHEDULED
[21:44:19.338] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:5:0) after 3m42s
[21:48:01.657] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:5:0)
[21:48:01.703] Build status: SCHEDULED
[21:48:01.703] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:6:0) after 5m27s
[21:53:28.726] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:6:0)
[21:53:28.772] Build status: SCHEDULED
[21:53:28.772] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:7:0) after 9m35s
[21:56:02.860] Received PubSub notification, asking Buildbucket for the build status
[21:56:02.885] Build status: STARTED
[22:03:03.947] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:7:0)
[22:03:03.998] Build status: STARTED
[22:03:03.998] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:9:0) after 8m49s
[22:11:53.113] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:9:0)
[22:11:53.163] Build status: STARTED
[22:11:53.163] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:10:0) after 6m5s
[22:17:58.310] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:10:0)
[22:17:58.347] Build status: STARTED
[22:17:58.347] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:11:0) after 2m39s
[22:20:37.463] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:11:0)
[22:20:37.491] Build status: STARTED
[22:20:37.491] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:12:0) after 5m40s
[22:26:17.692] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:12:0)
[22:26:17.727] Build status: STARTED
[22:26:17.727] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:13:0) after 7m11s
[22:33:28.747] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:13:0)
[22:33:28.778] Build status: STARTED
[22:33:28.778] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:14:0) after 5m57s
[22:39:25.762] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:14:0)
[22:39:25.786] Build status: STARTED
[22:39:25.786] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8956482428322933920:15:0) after 9m53s
[22:48:51.916] Received PubSub notification, asking Buildbucket for the build status
[22:48:51.982] Build:
{
"id": "8791052366370683217",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-rel-x64"
},
"createdBy": "project:dawn",
"createTime": "2023-01-24T21:36:06.217176469Z",
"startTime": "2023-01-24T21:56:01.215895Z",
"endTime": "2023-01-24T22:48:51.728841635Z",
"updateTime": "2023-01-24T22:48:51.728841635Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "c744a23d77d53b8e8e7b9d5c7d7439e2622034da",
"ref": "refs/heads/main"
}
}
}
[22:48:51.982] Invocation finished in 1h12m47.010092667s with status SUCCEEDED