[18:28:57.822] New invocation is queued and will start shortly
[18:28:57.822] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[18:28:58.855] Starting the invocation (attempt 1)
[18:28:58.886] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d1b49f40581b6336dd8ab8a03153f7dd65ecc109"
[18:28:58.886] Popped gitiles commit info from properties and tags
[18:28:58.886] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:28:58.887] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:28:58.888] Buildbucket request:
{
"requestId": "8916631535639955120",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "d1b49f40581b6336dd8ab8a03153f7dd65ecc109",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "d1b49f40581b6336dd8ab8a03153f7dd65ecc109"
},
"parent_build_id": "8751201829224010881",
"parent_builder_group": "chromium.win",
"parent_buildername": "Win Builder",
"parent_got_angle_revision": "926334570f2c209b30fd74cc6c4c34e24b9b8e41",
"parent_got_dawn_revision": "9fa8edf5c4ec7eead01cc9328ef5196fe15998cc",
"parent_got_revision": "d1b49f40581b6336dd8ab8a03153f7dd65ecc109",
"parent_got_revision_cp": "refs/heads/main@{#1283963}",
"parent_got_swiftshader_revision": "62c59c41e194c288c06739788bb0aad3c86b19bf",
"parent_got_v8_revision": "135cc4a503db76312071cbcb5b2f20e8dd341c5e",
"parent_got_v8_revision_cp": "refs/heads/12.5.173@{#1}",
"parent_got_webrtc_revision": "a90942457721d360f4055275d74e8a60a4233898",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#42014}",
"swarm_hashes": {
"blink_web_tests": "90d9ea2eadbebb6332c764a3ae61a4dffbd72d4600bf71010e6f2230c4ba2b9d/565",
"blink_wpt_tests": "0ef075f3deaa05404af88ebb9864d1509fcddcdb2e1fc5d1a808eb4bd24407ed/565"
},
"swarming_command_lines_cwd": "out\\Release",
"swarming_command_lines_digest": "21ceac6fffb9fba639c22e1ab18c7ca27056f83f7d365d2e79705b3d04b81cbc/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d1b49f40581b6336dd8ab8a03153f7dd65ecc109",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916631535639955120"
},
{
"key": "scheduler_job_id",
"value": "chromium/WebKit Win10"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Win Builder"
},
{
"key": "parent_buildnumber",
"value": "198651"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:28:59.468] Scheduled build:
{
"id": "8751201473783622961",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"number": 131924,
"createdBy": "project:chromium",
"createTime": "2024-04-08T18:28:58.964297400Z",
"updateTime": "2024-04-08T18:28:58.964297400Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d1b49f40581b6336dd8ab8a03153f7dd65ecc109",
"ref": "refs/heads/main"
}
}
}
[18:28:59.468] Task URL: https://cr-buildbucket.appspot.com/build/8751201473783622961
[18:28:59.468] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:2:0) after 7m15s
[18:29:00.351] Received PubSub notification, asking Buildbucket for the build status
[18:29:00.372] Build status: SCHEDULED
[18:29:12.615] Received PubSub notification, asking Buildbucket for the build status
[18:29:12.648] Build status: STARTED
[18:36:14.535] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:2:0)
[18:36:14.571] Build status: STARTED
[18:36:14.571] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:5:0) after 6m42s
[18:42:56.589] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:5:0)
[18:42:56.615] Build status: STARTED
[18:42:56.615] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:6:0) after 5m20s
[18:48:16.639] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:6:0)
[18:48:16.673] Build status: STARTED
[18:48:16.673] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:7:0) after 5m23s
[18:53:40.040] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:7:0)
[18:53:40.057] Build status: STARTED
[18:53:40.057] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:8:0) after 7m3s
[19:00:43.874] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:8:0)
[19:00:43.907] Build status: STARTED
[19:00:43.907] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:9:0) after 6m8s
[19:06:51.936] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:9:0)
[19:06:52.008] Build status: STARTED
[19:06:52.008] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:10:0) after 2m43s
[19:09:35.049] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:10:0)
[19:09:35.123] Build status: STARTED
[19:09:35.123] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:11:0) after 6m25s
[19:16:00.150] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:11:0)
[19:16:00.169] Build status: STARTED
[19:16:00.169] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:12:0) after 3m1s
[19:19:01.189] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:12:0)
[19:19:01.233] Build status: STARTED
[19:19:01.233] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:13:0) after 2m28s
[19:21:29.375] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:13:0)
[19:21:29.399] Build status: STARTED
[19:21:29.399] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:14:0) after 6m27s
[19:27:56.413] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:14:0)
[19:27:56.437] Build status: STARTED
[19:27:56.437] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:15:0) after 2m34s
[19:30:30.510] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:15:0)
[19:30:30.545] Build status: STARTED
[19:30:30.545] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:16:0) after 8m31s
[19:39:01.573] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:16:0)
[19:39:01.593] Build status: STARTED
[19:39:01.593] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:17:0) after 8m44s
[19:47:45.735] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:17:0)
[19:47:45.756] Build status: STARTED
[19:47:45.756] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:18:0) after 3m46s
[19:51:31.774] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:18:0)
[19:51:31.802] Build status: STARTED
[19:51:31.802] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:19:0) after 7m29s
[19:59:00.868] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:19:0)
[19:59:00.888] Build status: STARTED
[19:59:00.888] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:20:0) after 5m33s
[20:04:33.904] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:20:0)
[20:04:33.922] Build status: STARTED
[20:04:33.922] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:21:0) after 3m48s
[20:08:22.009] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:21:0)
[20:08:22.078] Build status: STARTED
[20:08:22.078] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:22:0) after 6m43s
[20:15:05.256] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:22:0)
[20:15:05.283] Build status: STARTED
[20:15:05.283] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:23:0) after 7m58s
[20:23:03.319] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:23:0)
[20:23:03.341] Build status: STARTED
[20:23:03.341] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:24:0) after 1m15s
[20:24:18.422] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:24:0)
[20:24:18.443] Build status: STARTED
[20:24:18.443] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:25:0) after 6m5s
[20:30:23.602] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:25:0)
[20:30:23.621] Build status: STARTED
[20:30:23.621] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:26:0) after 5m59s
[20:36:22.642] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:26:0)
[20:36:22.686] Build status: STARTED
[20:36:22.686] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:27:0) after 7m27s
[20:43:49.707] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:27:0)
[20:43:49.782] Build status: STARTED
[20:43:49.782] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:28:0) after 6m50s
[20:50:39.961] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:28:0)
[20:50:39.982] Build status: STARTED
[20:50:39.982] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:29:0) after 7m40s
[20:58:20.037] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:29:0)
[20:58:20.055] Build status: STARTED
[20:58:20.055] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:30:0) after 9m47s
[21:08:07.076] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:30:0)
[21:08:07.106] Build status: STARTED
[21:08:07.106] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:31:0) after 4m4s
[21:12:11.135] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:31:0)
[21:12:11.187] Build status: STARTED
[21:12:11.187] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:32:0) after 7m38s
[21:19:49.205] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:32:0)
[21:19:49.224] Build status: STARTED
[21:19:49.224] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:33:0) after 4m49s
[21:24:38.336] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:33:0)
[21:24:38.362] Build status: STARTED
[21:24:38.362] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:34:0) after 6m45s
[21:31:23.387] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:34:0)
[21:31:23.411] Build status: STARTED
[21:31:23.411] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:35:0) after 3m56s
[21:35:19.434] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:35:0)
[21:35:19.451] Build status: STARTED
[21:35:19.451] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:36:0) after 6m12s
[21:41:31.503] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:36:0)
[21:41:31.565] Build status: STARTED
[21:41:31.565] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:37:0) after 2m54s
[21:44:25.608] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:37:0)
[21:44:25.631] Build status: STARTED
[21:44:25.631] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8916631535639955120:38:0) after 9m17s
[21:46:18.090] Received PubSub notification, asking Buildbucket for the build status
[21:46:18.147] Build:
{
"id": "8751201473783622961",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"number": 131924,
"createdBy": "project:chromium",
"createTime": "2024-04-08T18:28:58.964297400Z",
"startTime": "2024-04-08T18:29:12.427908123Z",
"endTime": "2024-04-08T21:46:17.844090286Z",
"updateTime": "2024-04-08T21:46:17.844090286Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d1b49f40581b6336dd8ab8a03153f7dd65ecc109",
"ref": "refs/heads/main"
}
}
}
[21:46:18.147] Invocation finished in 3h17m20.337217602s with status SUCCEEDED