[03:27:02.100] New invocation is queued and will start shortly
[03:27:02.100] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[03:27:03.234] Starting the invocation (attempt 1)
[03:27:03.259] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1cd71d665d36851d67e8c0dd8a2cce2673d0a731"
[03:27:03.259] Popped gitiles commit info from properties and tags
[03:27:03.259] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:27:03.259] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:27:03.259] Buildbucket request:
{
"requestId": "8931546182578838944",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "1cd71d665d36851d67e8c0dd8a2cce2673d0a731",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "1cd71d665d36851d67e8c0dd8a2cce2673d0a731"
},
"parent_build_id": "8766117829150682001",
"parent_builder_group": "chromium.win",
"parent_buildername": "Win Builder",
"parent_got_angle_revision": "3596ab4c01d361aaa66360692a132efc60db811b",
"parent_got_dawn_revision": "3c476fa3cda5c5d49e7c0db38bc5cf1c7b7c1a7c",
"parent_got_revision": "1cd71d665d36851d67e8c0dd8a2cce2673d0a731",
"parent_got_revision_cp": "refs/heads/main@{#1215913}",
"parent_got_swiftshader_revision": "d9ec9befba05a8dfca09c1e88f3f7be0e4b153c6",
"parent_got_v8_revision": "b3cb0818156bed06f359c96d274ec5db90bd7699",
"parent_got_v8_revision_cp": "refs/heads/12.0.245@{#1}",
"parent_got_webrtc_revision": "2e1f16d55c66ded230db084cdd517a9b9dfb21bc",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41014}",
"swarm_hashes": {
"blink_web_tests": "4c7831a254014187e330f4ae73b656731410cbfb5e49edba3a6563129ae0986d/565",
"blink_wpt_tests": "ffeb0484c1f2556115603ce5021782c84ee18e77c0d3ba40bad635440aa35ab3/565"
},
"swarming_command_lines_cwd": "out\\Release",
"swarming_command_lines_digest": "21ceac6fffb9fba639c22e1ab18c7ca27056f83f7d365d2e79705b3d04b81cbc/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1cd71d665d36851d67e8c0dd8a2cce2673d0a731",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931546182578838944"
},
{
"key": "scheduler_job_id",
"value": "chromium/WebKit Win10"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Win Builder"
},
{
"key": "parent_buildnumber",
"value": "181569"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:27:03.940] Scheduled build:
{
"id": "8766116120645750961",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"number": 123809,
"createdBy": "project:chromium",
"createTime": "2023-10-27T03:27:03.313606694Z",
"updateTime": "2023-10-27T03:27:03.313606694Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1cd71d665d36851d67e8c0dd8a2cce2673d0a731",
"ref": "refs/heads/main"
}
}
}
[03:27:03.940] Task URL: https://cr-buildbucket.appspot.com/build/8766116120645750961
[03:27:03.940] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:2:0) after 5m40s
[03:27:04.886] Received PubSub notification, asking Buildbucket for the build status
[03:27:04.935] Build status: SCHEDULED
[03:30:08.189] Received PubSub notification, asking Buildbucket for the build status
[03:30:08.243] Build status: STARTED
[03:32:43.989] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:2:0)
[03:32:44.081] Build status: STARTED
[03:32:44.081] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:5:0) after 8m24s
[03:41:08.117] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:5:0)
[03:41:08.146] Build status: STARTED
[03:41:08.146] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:6:0) after 6m40s
[03:47:48.822] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:6:0)
[03:47:48.839] Build status: STARTED
[03:47:48.839] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:7:0) after 4m9s
[03:51:58.023] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:7:0)
[03:51:58.039] Build status: STARTED
[03:51:58.039] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:8:0) after 6m44s
[03:58:42.055] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:8:0)
[03:58:42.105] Build status: STARTED
[03:58:42.105] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8931546182578838944:9:0) after 3m35s
[04:00:41.246] Received PubSub notification, asking Buildbucket for the build status
[04:00:41.268] Build:
{
"id": "8766116120645750961",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"number": 123809,
"createdBy": "project:chromium",
"createTime": "2023-10-27T03:27:03.313606694Z",
"startTime": "2023-10-27T03:30:07.569467Z",
"endTime": "2023-10-27T04:00:40.963358772Z",
"updateTime": "2023-10-27T04:00:40.963358772Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1cd71d665d36851d67e8c0dd8a2cce2673d0a731",
"ref": "refs/heads/main"
}
}
}
[04:00:41.268] Invocation finished in 33m39.181243693s with status SUCCEEDED