[15:07:28.329] New invocation is queued and will start shortly
[15:07:29.508] Starting the invocation (attempt 1)
[15:07:29.536] Popped buildset tag "buildset:commit/gitiles/dawn.googlesource.com/dawn/+/59c8fee8d1d2a72d8598bb7172579a5e44144226"
[15:07:29.536] Popped gitiles commit info from properties and tags
[15:07:29.536] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:07:29.536] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:07:29.537] Buildbucket request:
{
"requestId": "8912567348897748384",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-dbg-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912567348897748384",
"job": "dawn/win-msvc-dbg-x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "494b6ae760b63a0cbb4a844801a3e6e6cec9929f"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@494b6ae760b63a0cbb4a844801a3e6e6cec9929f",
"title": "494b6ae760b63a0cbb4a844801a3e6e6cec9929f",
"url": "https://dawn.googlesource.com/dawn/+/494b6ae760b63a0cbb4a844801a3e6e6cec9929f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dawn.googlesource.com/dawn",
"revision": "4e043e9741d726a213b588a369d0c5623370c910"
},
"id": "https://dawn.googlesource.com/dawn/+/refs/heads/main@4e043e9741d726a213b588a369d0c5623370c910",
"title": "4e043e9741d726a213b588a369d0c5623370c910",
"url": "https://dawn.googlesource.com/dawn/+/4e043e9741d726a213b588a369d0c5623370c910"
},
{
"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"
}
]
}
},
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "59c8fee8d1d2a72d8598bb7172579a5e44144226",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912567348897748384"
},
{
"key": "scheduler_job_id",
"value": "dawn/win-msvc-dbg-x64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:07:30.023] Scheduled build:
{
"id": "8747137286901893793",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-dbg-x64"
},
"createdBy": "project:dawn",
"createTime": "2024-05-23T15:07:29.610210183Z",
"updateTime": "2024-05-23T15:07:29.610210183Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "59c8fee8d1d2a72d8598bb7172579a5e44144226",
"ref": "refs/heads/main"
}
}
}
[15:07:30.023] Task URL: https://cr-buildbucket.appspot.com/build/8747137286901893793
[15:07:30.023] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:2:0) after 9m42s
[15:07:30.981] Received PubSub notification, asking Buildbucket for the build status
[15:07:31.017] Build status: SCHEDULED
[15:17:12.041] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:2:0)
[15:17:12.109] Build status: SCHEDULED
[15:17:12.109] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:4:0) after 4m56s
[15:22:08.129] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:4:0)
[15:22:08.147] Build status: SCHEDULED
[15:22:08.147] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:5:0) after 4m40s
[15:26:48.170] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:5:0)
[15:26:48.239] Build status: SCHEDULED
[15:26:48.240] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:6:0) after 4m27s
[15:31:15.304] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:6:0)
[15:31:15.320] Build status: SCHEDULED
[15:31:15.320] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:7:0) after 4m37s
[15:35:52.383] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:7:0)
[15:35:52.420] Build status: SCHEDULED
[15:35:52.420] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:8:0) after 8m40s
[15:44:32.944] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:8:0)
[15:44:33.003] Build status: SCHEDULED
[15:44:33.003] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:9:0) after 4m50s
[15:46:31.989] Received PubSub notification, asking Buildbucket for the build status
[15:46:32.026] Build status: STARTED
[15:49:23.077] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:9:0)
[15:49:23.103] Build status: STARTED
[15:49:23.103] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:11:0) after 8m1s
[15:57:24.131] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:11:0)
[15:57:24.216] Build status: STARTED
[15:57:24.216] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:12:0) after 9m15s
[16:06:39.233] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:12:0)
[16:06:39.260] Build status: STARTED
[16:06:39.260] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:13:0) after 3m9s
[16:09:48.262] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:13:0)
[16:09:48.288] Build status: STARTED
[16:09:48.288] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:14:0) after 9m10s
[16:18:58.314] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:14:0)
[16:18:58.335] Build status: STARTED
[16:18:58.335] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:15:0) after 8m25s
[16:27:23.354] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:15:0)
[16:27:23.435] Build status: STARTED
[16:27:23.435] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:16:0) after 5m53s
[16:33:16.454] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:16:0)
[16:33:16.472] Build status: STARTED
[16:33:16.472] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:17:0) after 7m0s
[16:40:16.538] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:17:0)
[16:40:16.577] Build status: STARTED
[16:40:16.577] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:18:0) after 3m10s
[16:43:26.581] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:18:0)
[16:43:26.600] Build status: STARTED
[16:43:26.600] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:19:0) after 8m39s
[16:52:05.651] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:19:0)
[16:52:05.680] Build status: STARTED
[16:52:05.680] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:20:0) after 2m7s
[16:54:12.705] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:20:0)
[16:54:12.738] Build status: STARTED
[16:54:12.738] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:21:0) after 6m53s
[17:01:05.768] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:21:0)
[17:01:05.797] Build status: STARTED
[17:01:05.797] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:22:0) after 9m23s
[17:10:28.823] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:22:0)
[17:10:28.853] Build status: STARTED
[17:10:28.853] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:23:0) after 7m49s
[17:18:17.871] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:23:0)
[17:18:17.893] Build status: STARTED
[17:18:17.894] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:24:0) after 8m45s
[17:27:02.912] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:24:0)
[17:27:02.940] Build status: STARTED
[17:27:02.940] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:25:0) after 1m24s
[17:28:27.056] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:25:0)
[17:28:27.076] Build status: STARTED
[17:28:27.076] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:26:0) after 5m3s
[17:33:30.172] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:26:0)
[17:33:30.245] Build status: STARTED
[17:33:30.245] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:27:0) after 6m59s
[17:40:29.236] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:27:0)
[17:40:29.258] Build status: STARTED
[17:40:29.258] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:28:0) after 1m24s
[17:41:53.250] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:28:0)
[17:41:53.286] Build status: STARTED
[17:41:53.286] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:29:0) after 5m41s
[17:47:34.340] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:29:0)
[17:47:34.361] Build status: STARTED
[17:47:34.361] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:30:0) after 5m7s
[17:52:41.396] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:30:0)
[17:52:41.455] Build status: STARTED
[17:52:41.455] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:31:0) after 8m9s
[18:00:50.663] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:31:0)
[18:00:50.688] Build status: STARTED
[18:00:50.688] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:32:0) after 8m42s
[18:09:32.674] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:32:0)
[18:09:32.696] Build status: STARTED
[18:09:32.696] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:33:0) after 5m1s
[18:14:33.814] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:33:0)
[18:14:33.888] Build status: STARTED
[18:14:33.888] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:34:0) after 5m28s
[18:20:01.933] Handling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:34:0)
[18:20:01.963] Build status: STARTED
[18:20:01.963] Scheduling timer "check-buildbucket-build-status" (dawn/win-msvc-dbg-x64:8912567348897748384:35:0) after 5m21s
[18:23:39.287] Received PubSub notification, asking Buildbucket for the build status
[18:23:39.309] Build:
{
"id": "8747137286901893793",
"builder": {
"project": "dawn",
"bucket": "ci",
"builder": "win-msvc-dbg-x64"
},
"createdBy": "project:dawn",
"createTime": "2024-05-23T15:07:29.610210183Z",
"startTime": "2024-05-23T15:46:31.814095657Z",
"endTime": "2024-05-23T18:23:39.056760019Z",
"updateTime": "2024-05-23T18:23:39.056760019Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dawn.googlesource.com",
"project": "dawn",
"id": "59c8fee8d1d2a72d8598bb7172579a5e44144226",
"ref": "refs/heads/main"
}
}
}
[18:23:39.309] Invocation finished in 3h16m10.986565898s with status SUCCEEDED