[21:07:21.387] New invocation is queued and will start shortly
[21:07:23.268] Starting the invocation (attempt 1)
[21:07:23.302] Popped buildset tag "buildset:commit/gitiles/dawn.googlesource.com/dawn/+/f9a9918278ec1142979c6b2d0e43dc3406f66eda"
[21:07:23.302] Popped gitiles commit info from properties and tags
[21:07:23.302] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:07:23.302] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:07:23.302] Buildbucket request:
{
"requestId": "8912635303910604352",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-clang-dbg-x86"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912635303910604352",
"job": "dawn/win-clang-dbg-x86",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "f9a9918278ec1142979c6b2d0e43dc3406f66eda"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@f9a9918278ec1142979c6b2d0e43dc3406f66eda",
"title": "f9a9918278ec1142979c6b2d0e43dc3406f66eda",
"url": "https://dawn.googlesource.com/dawn/+/f9a9918278ec1142979c6b2d0e43dc3406f66eda"
}
]
}
},
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "f9a9918278ec1142979c6b2d0e43dc3406f66eda",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912635303910604352"
},
{
"key": "scheduler_job_id",
"value": "dawn/win-clang-dbg-x86"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:07:23.836] Scheduled build:
{
"id": "8747205241143883537",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-clang-dbg-x86"
},
"createdBy": "project:dawn",
"createTime": "2024-05-22T21:07:23.394283115Z",
"updateTime": "2024-05-22T21:07:23.394283115Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "f9a9918278ec1142979c6b2d0e43dc3406f66eda",
"ref": "refs/heads/main"
}
}
}
[21:07:23.836] Task URL: https://cr-buildbucket.appspot.com/build/8747205241143883537
[21:07:23.836] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:2:0) after 4m45s
[21:07:24.857] Received PubSub notification, asking Buildbucket for the build status
[21:07:24.892] Build status: SCHEDULED
[21:12:08.862] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:2:0)
[21:12:08.952] Build status: SCHEDULED
[21:12:08.952] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:4:0) after 1m59s
[21:14:07.960] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:4:0)
[21:14:08.078] Build status: SCHEDULED
[21:14:08.078] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:5:0) after 2m37s
[21:16:45.109] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:5:0)
[21:16:45.146] Build status: SCHEDULED
[21:16:45.146] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:6:0) after 5m42s
[21:22:27.181] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:6:0)
[21:22:27.213] Build status: SCHEDULED
[21:22:27.213] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:7:0) after 6m8s
[21:28:35.236] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:7:0)
[21:28:35.258] Build status: SCHEDULED
[21:28:35.258] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:8:0) after 9m8s
[21:37:43.287] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:8:0)
[21:37:43.328] Build status: SCHEDULED
[21:37:43.328] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:9:0) after 4m53s
[21:42:36.393] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:9:0)
[21:42:36.425] Build status: SCHEDULED
[21:42:36.425] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:10:0) after 7m8s
[21:49:44.489] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:10:0)
[21:49:44.508] Build status: SCHEDULED
[21:49:44.508] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:11:0) after 3m45s
[21:53:29.661] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:11:0)
[21:53:29.682] Build status: SCHEDULED
[21:53:29.682] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:12:0) after 2m23s
[21:55:52.704] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:12:0)
[21:55:52.868] Build status: SCHEDULED
[21:55:52.868] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:13:0) after 9m7s
[22:04:59.884] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:13:0)
[22:04:59.917] Build status: SCHEDULED
[22:04:59.917] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:14:0) after 9m46s
[22:14:45.930] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:14:0)
[22:14:45.951] Build status: SCHEDULED
[22:14:45.951] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:15:0) after 3m52s
[22:18:38.024] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:15:0)
[22:18:38.089] Build status: SCHEDULED
[22:18:38.089] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:16:0) after 5m24s
[22:24:02.185] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:16:0)
[22:24:02.409] Build status: SCHEDULED
[22:24:02.409] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:17:0) after 8m28s
[22:26:04.006] Received PubSub notification, asking Buildbucket for the build status
[22:26:04.036] Build status: STARTED
[22:32:30.428] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:17:0)
[22:32:30.459] Build status: STARTED
[22:32:30.459] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:19:0) after 5m0s
[22:37:30.478] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:19:0)
[22:37:30.510] Build status: STARTED
[22:37:30.510] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:20:0) after 2m32s
[22:40:02.530] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:20:0)
[22:40:02.549] Build status: STARTED
[22:40:02.549] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:21:0) after 7m54s
[22:47:56.598] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:21:0)
[22:47:56.627] Build status: STARTED
[22:47:56.627] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:22:0) after 4m13s
[22:52:09.641] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:22:0)
[22:52:09.664] Build status: STARTED
[22:52:09.664] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:23:0) after 1m22s
[22:53:31.730] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:23:0)
[22:53:31.753] Build status: STARTED
[22:53:31.753] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:24:0) after 3m0s
[22:56:31.736] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:24:0)
[22:56:31.755] Build status: STARTED
[22:56:31.755] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:25:0) after 6m37s
[23:03:08.768] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:25:0)
[23:03:08.792] Build status: STARTED
[23:03:08.792] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:26:0) after 7m26s
[23:10:34.883] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:26:0)
[23:10:34.950] Build status: STARTED
[23:10:34.950] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:27:0) after 5m45s
[23:16:20.104] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:27:0)
[23:16:20.134] Build status: STARTED
[23:16:20.134] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:28:0) after 2m13s
[23:18:33.163] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:28:0)
[23:18:33.180] Build status: STARTED
[23:18:33.180] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:29:0) after 4m7s
[23:22:40.277] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:29:0)
[23:22:40.461] Build status: STARTED
[23:22:40.461] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:30:0) after 1m48s
[23:24:28.487] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:30:0)
[23:24:28.512] Build status: STARTED
[23:24:28.512] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:31:0) after 7m20s
[23:31:48.530] Handling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:31:0)
[23:31:48.548] Build status: STARTED
[23:31:48.548] Scheduling timer "check-buildbucket-build-status" (dawn/win-clang-dbg-x86:8912635303910604352:32:0) after 6m6s
[23:35:39.787] Received PubSub notification, asking Buildbucket for the build status
[23:35:39.811] Build:
{
"id": "8747205241143883537",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-clang-dbg-x86"
},
"createdBy": "project:dawn",
"createTime": "2024-05-22T21:07:23.394283115Z",
"startTime": "2024-05-22T22:26:03.770695159Z",
"endTime": "2024-05-22T23:35:39.539145914Z",
"updateTime": "2024-05-22T23:35:39.539145914Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "f9a9918278ec1142979c6b2d0e43dc3406f66eda",
"ref": "refs/heads/main"
}
}
}
[23:35:39.811] Invocation finished in 2h28m18.438090226s with status SUCCEEDED