[16:22:37.145] New invocation is queued and will start shortly
[16:22:38.402] Starting the invocation (attempt 1)
[16:22:38.427] Popped buildset tag "buildset:commit/gitiles/dawn.googlesource.com/dawn/+/143523a12f42d663bc0473cf5d8468559d4eb192"
[16:22:38.427] Popped gitiles commit info from properties and tags
[16:22:38.427] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:22:38.427] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:22:38.427] Buildbucket request:
{
"requestId": "8912562621073139392",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-rel-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912562621073139392",
"job": "dawn/win-msvc-rel-x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "81da61165530deb3049ad38a54309278c3565413"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@81da61165530deb3049ad38a54309278c3565413",
"title": "81da61165530deb3049ad38a54309278c3565413",
"url": "https://dawn.googlesource.com/dawn/+/81da61165530deb3049ad38a54309278c3565413"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "59c8fee8d1d2a72d8598bb7172579a5e44144226"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@59c8fee8d1d2a72d8598bb7172579a5e44144226",
"title": "59c8fee8d1d2a72d8598bb7172579a5e44144226",
"url": "https://dawn.googlesource.com/dawn/+/59c8fee8d1d2a72d8598bb7172579a5e44144226"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "59eb7f31f5507fbddcfead963581523c78e69b8f"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@59eb7f31f5507fbddcfead963581523c78e69b8f",
"title": "59eb7f31f5507fbddcfead963581523c78e69b8f",
"url": "https://dawn.googlesource.com/dawn/+/59eb7f31f5507fbddcfead963581523c78e69b8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "143523a12f42d663bc0473cf5d8468559d4eb192"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@143523a12f42d663bc0473cf5d8468559d4eb192",
"title": "143523a12f42d663bc0473cf5d8468559d4eb192",
"url": "https://dawn.googlesource.com/dawn/+/143523a12f42d663bc0473cf5d8468559d4eb192"
}
]
}
},
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "143523a12f42d663bc0473cf5d8468559d4eb192",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912562621073139392"
},
{
"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"
}
}
[16:22:38.864] Scheduled build:
{
"id": "8747132558996138321",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-rel-x64"
},
"createdBy": "project:dawn",
"createTime": "2024-05-23T16:22:38.492901266Z",
"updateTime": "2024-05-23T16:22:38.492901266Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "143523a12f42d663bc0473cf5d8468559d4eb192",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:22:38.864] Task URL: https://cr-buildbucket.appspot.com/build/8747132558996138321
[16:22:38.864] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:2:0) after 6m37s
[16:22:39.820] Received PubSub notification, asking Buildbucket for the build status
[16:22:39.896] Build status: SCHEDULED
[16:29:15.933] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:2:0)
[16:29:15.963] Build status: SCHEDULED
[16:29:15.963] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:4:0) after 2m49s
[16:32:04.982] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:4:0)
[16:32:05.014] Build status: SCHEDULED
[16:32:05.014] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:5:0) after 6m53s
[16:38:58.078] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:5:0)
[16:38:58.109] Build status: SCHEDULED
[16:38:58.109] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:6:0) after 3m34s
[16:42:32.128] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:6:0)
[16:42:32.158] Build status: SCHEDULED
[16:42:32.158] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:7:0) after 9m20s
[16:51:52.224] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:7:0)
[16:51:52.249] Build status: SCHEDULED
[16:51:52.249] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:8:0) after 9m11s
[17:01:03.365] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:8:0)
[17:01:03.402] Build status: SCHEDULED
[17:01:03.402] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:9:0) after 1m22s
[17:02:25.435] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:9:0)
[17:02:25.465] Build status: SCHEDULED
[17:02:25.465] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:10:0) after 7m54s
[17:10:19.630] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:10:0)
[17:10:19.665] Build status: SCHEDULED
[17:10:19.665] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:11:0) after 9m41s
[17:20:00.687] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:11:0)
[17:20:00.703] Build status: SCHEDULED
[17:20:00.703] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:12:0) after 1m50s
[17:21:50.731] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:12:0)
[17:21:50.768] Build status: SCHEDULED
[17:21:50.769] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:13:0) after 4m2s
[17:25:52.791] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:13:0)
[17:25:52.825] Build status: SCHEDULED
[17:25:52.825] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:14:0) after 8m56s
[17:34:48.801] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:14:0)
[17:34:48.829] Build status: SCHEDULED
[17:34:48.829] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:15:0) after 2m55s
[17:37:43.829] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:15:0)
[17:37:43.850] Build status: SCHEDULED
[17:37:43.850] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:16:0) after 2m36s
[17:40:19.840] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:16:0)
[17:40:19.862] Build status: SCHEDULED
[17:40:19.862] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:17:0) after 7m45s
[17:48:04.879] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:17:0)
[17:48:04.900] Build status: SCHEDULED
[17:48:04.900] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:18:0) after 4m9s
[17:52:13.922] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:18:0)
[17:52:14.098] Build status: SCHEDULED
[17:52:14.098] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:19:0) after 5m10s
[17:53:55.550] Received PubSub notification, asking Buildbucket for the build status
[17:53:55.579] Build status: STARTED
[17:57:24.288] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:19:0)
[17:57:24.316] Build status: STARTED
[17:57:24.316] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:21:0) after 4m21s
[18:01:45.370] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:21:0)
[18:01:45.408] Build status: STARTED
[18:01:45.408] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:22:0) after 4m46s
[18:06:31.407] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:22:0)
[18:06:31.473] Build status: STARTED
[18:06:31.473] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:23:0) after 7m53s
[18:14:24.490] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:23:0)
[18:14:24.508] Build status: STARTED
[18:14:24.508] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:24:0) after 8m45s
[18:23:09.601] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:24:0)
[18:23:09.733] Build status: STARTED
[18:23:09.733] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:25:0) after 8m46s
[18:31:55.773] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:25:0)
[18:31:55.792] Build status: STARTED
[18:31:55.792] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:26:0) after 1m17s
[18:33:12.813] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:26:0)
[18:33:12.870] Build status: STARTED
[18:33:12.870] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:27:0) after 5m31s
[18:38:43.912] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:27:0)
[18:38:43.952] Build status: STARTED
[18:38:43.952] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:28:0) after 5m59s
[18:44:42.967] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:28:0)
[18:44:42.987] Build status: STARTED
[18:44:42.987] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:29:0) after 7m8s
[18:51:51.029] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:29:0)
[18:51:51.048] Build status: STARTED
[18:51:51.048] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:30:0) after 6m50s
[18:58:41.068] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:30:0)
[18:58:41.123] Build status: STARTED
[18:58:41.123] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:31:0) after 7m31s
[19:06:12.238] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:31:0)
[19:06:12.260] Build status: STARTED
[19:06:12.260] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:32:0) after 8m7s
[19:14:19.278] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:32:0)
[19:14:19.295] Build status: STARTED
[19:14:19.295] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:33:0) after 3m16s
[19:17:35.312] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:33:0)
[19:17:35.331] Build status: STARTED
[19:17:35.331] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:34:0) after 2m52s
[19:20:27.356] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:34:0)
[19:20:27.376] Build status: STARTED
[19:20:27.376] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:35:0) after 4m34s
[19:25:01.374] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:35:0)
[19:25:01.398] Build status: STARTED
[19:25:01.398] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:36:0) after 2m22s
[19:27:23.434] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:36:0)
[19:27:23.559] Build status: STARTED
[19:27:23.560] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:37:0) after 8m2s
[19:35:25.588] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:37:0)
[19:35:25.683] Build status: STARTED
[19:35:25.683] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:38:0) after 6m44s
[19:42:09.714] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:38:0)
[19:42:09.765] Build status: STARTED
[19:42:09.765] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-rel-x64:8912562621073139392:39:0) after 9m4s
[19:50:51.328] Received PubSub notification, asking Buildbucket for the build status
[19:50:51.348] Build:
{
"id": "8747132558996138321",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-rel-x64"
},
"createdBy": "project:dawn",
"createTime": "2024-05-23T16:22:38.492901266Z",
"startTime": "2024-05-23T17:53:55.312836742Z",
"endTime": "2024-05-23T19:50:51.038273091Z",
"updateTime": "2024-05-23T19:50:51.038273091Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "143523a12f42d663bc0473cf5d8468559d4eb192",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:50:51.348] Invocation finished in 3h28m14.219384713s with status SUCCEEDED