[21:03:30.233] New invocation is queued and will start shortly
[21:03:31.315] Starting the invocation (attempt 1)
[21:03:31.366] Popped buildset tag "buildset:commit/gitiles/dawn.googlesource.com/dawn/+/6931379dd7bae668dc99c91e0511d0efec2238c6"
[21:03:31.366] Popped gitiles commit info from properties and tags
[21:03:31.366] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:03:31.366] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:03:31.367] Buildbucket request:
{
"requestId": "8910642413025274192",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "cmake-win-msvc-dbg-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910642413025274192",
"job": "dawn/cmake-win-msvc-dbg-x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "8f8f8d78f4ddd932a692159fed0178c0418ba9c8"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@8f8f8d78f4ddd932a692159fed0178c0418ba9c8",
"title": "8f8f8d78f4ddd932a692159fed0178c0418ba9c8",
"url": "https://dawn.googlesource.com/dawn/+/8f8f8d78f4ddd932a692159fed0178c0418ba9c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "58fc3f1cc918266ac6aa993524c4336b5dd2b2c7"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@58fc3f1cc918266ac6aa993524c4336b5dd2b2c7",
"title": "58fc3f1cc918266ac6aa993524c4336b5dd2b2c7",
"url": "https://dawn.googlesource.com/dawn/+/58fc3f1cc918266ac6aa993524c4336b5dd2b2c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "e902718db52bef84cbd809bcc137cd7778ceba18"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@e902718db52bef84cbd809bcc137cd7778ceba18",
"title": "e902718db52bef84cbd809bcc137cd7778ceba18",
"url": "https://dawn.googlesource.com/dawn/+/e902718db52bef84cbd809bcc137cd7778ceba18"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "8a034740a9d439507696c757c3d2eeadf4ed348c"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@8a034740a9d439507696c757c3d2eeadf4ed348c",
"title": "8a034740a9d439507696c757c3d2eeadf4ed348c",
"url": "https://dawn.googlesource.com/dawn/+/8a034740a9d439507696c757c3d2eeadf4ed348c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "9f539951439ab5720aa0d591aa3e250505306d5c"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@9f539951439ab5720aa0d591aa3e250505306d5c",
"title": "9f539951439ab5720aa0d591aa3e250505306d5c",
"url": "https://dawn.googlesource.com/dawn/+/9f539951439ab5720aa0d591aa3e250505306d5c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "251f00ded0aae560c176c32d409302ca51ba6ece"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@251f00ded0aae560c176c32d409302ca51ba6ece",
"title": "251f00ded0aae560c176c32d409302ca51ba6ece",
"url": "https://dawn.googlesource.com/dawn/+/251f00ded0aae560c176c32d409302ca51ba6ece"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "2cc6b3cedbdb980aa6321171ffe5f436930d8ce0"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@2cc6b3cedbdb980aa6321171ffe5f436930d8ce0",
"title": "2cc6b3cedbdb980aa6321171ffe5f436930d8ce0",
"url": "https://dawn.googlesource.com/dawn/+/2cc6b3cedbdb980aa6321171ffe5f436930d8ce0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "6931379dd7bae668dc99c91e0511d0efec2238c6"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@6931379dd7bae668dc99c91e0511d0efec2238c6",
"title": "6931379dd7bae668dc99c91e0511d0efec2238c6",
"url": "https://dawn.googlesource.com/dawn/+/6931379dd7bae668dc99c91e0511d0efec2238c6"
}
]
}
},
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "6931379dd7bae668dc99c91e0511d0efec2238c6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910642413025274192"
},
{
"key": "scheduler_job_id",
"value": "dawn/cmake-win-msvc-dbg-x64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:03:31.878] Scheduled build:
{
"id": "8745212351114249009",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "cmake-win-msvc-dbg-x64"
},
"createdBy": "project:dawn",
"createTime": "2024-06-13T21:03:31.431015584Z",
"updateTime": "2024-06-13T21:03:31.431015584Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "6931379dd7bae668dc99c91e0511d0efec2238c6",
"ref": "refs/heads/main"
}
}
}
[21:03:31.878] Task URL: https://cr-buildbucket.appspot.com/build/8745212351114249009
[21:03:31.878] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:2:0) after 1m42s
[21:03:32.756] Received PubSub notification, asking Buildbucket for the build status
[21:03:32.787] Build status: SCHEDULED
[21:05:13.855] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:2:0)
[21:05:13.884] Build status: SCHEDULED
[21:05:13.884] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:4:0) after 1m36s
[21:06:49.884] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:4:0)
[21:06:49.912] Build status: SCHEDULED
[21:06:49.912] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:5:0) after 1m54s
[21:08:43.985] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:5:0)
[21:08:44.043] Build status: SCHEDULED
[21:08:44.043] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:6:0) after 9m13s
[21:17:57.039] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:6:0)
[21:17:57.077] Build status: SCHEDULED
[21:17:57.077] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:7:0) after 7m44s
[21:25:41.114] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:7:0)
[21:25:41.160] Build status: SCHEDULED
[21:25:41.160] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:8:0) after 8m36s
[21:34:17.143] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:8:0)
[21:34:17.171] Build status: SCHEDULED
[21:34:17.171] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:9:0) after 5m22s
[21:39:39.356] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:9:0)
[21:39:39.378] Build status: SCHEDULED
[21:39:39.378] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:10:0) after 7m41s
[21:47:20.514] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:10:0)
[21:47:20.538] Build status: SCHEDULED
[21:47:20.538] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:11:0) after 1m31s
[21:48:51.560] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:11:0)
[21:48:51.583] Build status: SCHEDULED
[21:48:51.583] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:12:0) after 8m58s
[21:57:49.617] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:12:0)
[21:57:49.640] Build status: SCHEDULED
[21:57:49.640] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:13:0) after 8m53s
[22:06:42.681] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:13:0)
[22:06:42.703] Build status: SCHEDULED
[22:06:42.703] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:14:0) after 2m33s
[22:08:20.442] Received PubSub notification, asking Buildbucket for the build status
[22:08:20.488] Build status: STARTED
[22:09:15.739] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:14:0)
[22:09:15.760] Build status: STARTED
[22:09:15.760] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:16:0) after 9m54s
[22:19:09.776] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:16:0)
[22:19:09.809] Build status: STARTED
[22:19:09.809] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:17:0) after 9m8s
[22:28:17.877] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:17:0)
[22:28:17.925] Build status: STARTED
[22:28:17.925] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:18:0) after 7m43s
[22:36:00.997] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:18:0)
[22:36:01.043] Build status: STARTED
[22:36:01.043] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:19:0) after 2m49s
[22:38:50.068] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:19:0)
[22:38:50.097] Build status: STARTED
[22:38:50.097] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:20:0) after 8m15s
[22:47:05.128] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:20:0)
[22:47:05.177] Build status: STARTED
[22:47:05.177] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:21:0) after 9m28s
[22:56:33.196] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:21:0)
[22:56:33.217] Build status: STARTED
[22:56:33.217] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:22:0) after 4m0s
[23:00:33.234] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:22:0)
[23:00:33.257] Build status: STARTED
[23:00:33.257] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:23:0) after 4m21s
[23:04:54.291] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:23:0)
[23:04:54.323] Build status: STARTED
[23:04:54.323] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:24:0) after 7m34s
[23:12:28.318] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:24:0)
[23:12:28.345] Build status: STARTED
[23:12:28.345] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:25:0) after 4m11s
[23:16:39.362] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:25:0)
[23:16:39.416] Build status: STARTED
[23:16:39.416] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:26:0) after 5m0s
[23:21:39.837] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:26:0)
[23:21:39.858] Build status: STARTED
[23:21:39.858] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:27:0) after 1m13s
[23:22:52.878] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:27:0)
[23:22:52.899] Build status: STARTED
[23:22:52.899] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:28:0) after 6m15s
[23:29:07.918] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:28:0)
[23:29:07.949] Build status: STARTED
[23:29:07.949] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:29:0) after 2m36s
[23:31:43.983] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:29:0)
[23:31:43.998] Build status: STARTED
[23:31:43.998] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:30:0) after 9m42s
[23:41:26.066] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:30:0)
[23:41:26.094] Build status: STARTED
[23:41:26.094] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:31:0) after 1m56s
[23:43:22.105] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:31:0)
[23:43:22.126] Build status: STARTED
[23:43:22.126] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:32:0) after 2m49s
[23:46:11.203] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:32:0)
[23:46:11.223] Build status: STARTED
[23:46:11.223] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:33:0) after 8m49s
[23:55:00.240] Handling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:33:0)
[23:55:00.304] Build status: STARTED
[23:55:00.304] Scheduling timer "check-buildbucket-build-status" (dawn/cmake-win-msvc-dbg-x64:8910642413025274192:34:0) after 7m19s
[23:55:02.147] Received PubSub notification, asking Buildbucket for the build status
[23:55:02.193] Build:
{
"id": "8745212351114249009",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "cmake-win-msvc-dbg-x64"
},
"createdBy": "project:dawn",
"createTime": "2024-06-13T21:03:31.431015584Z",
"startTime": "2024-06-13T22:07:51.129670432Z",
"endTime": "2024-06-13T23:55:01.942201949Z",
"updateTime": "2024-06-13T23:55:01.942201949Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "6931379dd7bae668dc99c91e0511d0efec2238c6",
"ref": "refs/heads/main"
}
}
}
[23:55:02.193] Invocation finished in 2h51m31.967941938s with status SUCCEEDED