[21:43:26.266] New invocation is queued and will start shortly
[21:43:26.266] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[21:43:27.539] Starting the invocation (attempt 1)
[21:43:27.566] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1b6bfe2c785938af4676f803512e9cf4789d85c"
[21:43:27.566] Popped gitiles commit info from properties and tags
[21:43:27.566] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:43:27.566] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:43:27.566] Buildbucket request:
{
"requestId": "8919337209378756032",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "e1b6bfe2c785938af4676f803512e9cf4789d85c",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "e1b6bfe2c785938af4676f803512e9cf4789d85c"
},
"parent_build_id": "8753907675644138849",
"parent_builder_group": "chromium.win",
"parent_buildername": "Win Builder",
"parent_got_angle_revision": "d76505b8c36c82b9e51dbb6fdc4df5701addf23b",
"parent_got_dawn_revision": "65b18f2e7bfb10f7402800f72d71e74ae2856f3c",
"parent_got_revision": "e1b6bfe2c785938af4676f803512e9cf4789d85c",
"parent_got_revision_cp": "refs/heads/main@{#1270650}",
"parent_got_swiftshader_revision": "bbe6452b420c5ddc4b0fd421b0a3ce271262f4ca",
"parent_got_v8_revision": "a398e9499241fdf29aaddbab212b745e6c84fb9a",
"parent_got_v8_revision_cp": "refs/heads/12.4.204@{#1}",
"parent_got_webrtc_revision": "0268a05fd04d345f96082caf9b20e1949e3290bb",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41876}",
"swarm_hashes": {
"blink_web_tests": "870ee0edab272ca9b0f426f3ab8e3b10613bd4e94071a2f4b1fc6bebe277e83c/565",
"blink_wpt_tests": "636f2ef3fea8d1d969c6f831a3d58b4ead59a7de52f002b8849463927423c5c8/565"
},
"swarming_command_lines_cwd": "out\\Release",
"swarming_command_lines_digest": "21ceac6fffb9fba639c22e1ab18c7ca27056f83f7d365d2e79705b3d04b81cbc/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e1b6bfe2c785938af4676f803512e9cf4789d85c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8919337209378756032"
},
{
"key": "scheduler_job_id",
"value": "chromium/WebKit Win10"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Win Builder"
},
{
"key": "parent_buildnumber",
"value": "195488"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:43:28.423] Scheduled build:
{
"id": "8753907147213728001",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"number": 130526,
"createdBy": "project:chromium",
"createTime": "2024-03-09T21:43:27.705228101Z",
"updateTime": "2024-03-09T21:43:27.705228101Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e1b6bfe2c785938af4676f803512e9cf4789d85c",
"ref": "refs/heads/main"
}
}
}
[21:43:28.423] Task URL: https://cr-buildbucket.appspot.com/build/8753907147213728001
[21:43:28.423] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:2:0) after 4m55s
[21:43:28.931] Received PubSub notification, asking Buildbucket for the build status
[21:43:28.958] Build status: SCHEDULED
[21:48:23.508] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:2:0)
[21:48:23.535] Build status: SCHEDULED
[21:48:23.535] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:4:0) after 1m33s
[21:49:56.556] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:4:0)
[21:49:56.603] Build status: SCHEDULED
[21:49:56.604] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:5:0) after 2m5s
[21:52:01.630] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:5:0)
[21:52:01.660] Build status: SCHEDULED
[21:52:01.660] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:6:0) after 5m51s
[21:52:59.125] Received PubSub notification, asking Buildbucket for the build status
[21:52:59.142] Build status: STARTED
[21:57:53.038] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:6:0)
[21:57:53.060] Build status: STARTED
[21:57:53.060] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:8:0) after 3m21s
[22:01:15.281] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:8:0)
[22:01:15.362] Build status: STARTED
[22:01:15.362] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:9:0) after 6m53s
[22:08:08.485] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:9:0)
[22:08:08.508] Build status: STARTED
[22:08:08.508] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:10:0) after 4m50s
[22:12:58.524] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:10:0)
[22:12:58.550] Build status: STARTED
[22:12:58.550] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:11:0) after 3m27s
[22:16:25.568] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:11:0)
[22:16:25.586] Build status: STARTED
[22:16:25.586] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:12:0) after 9m44s
[22:26:09.598] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:12:0)
[22:26:09.624] Build status: STARTED
[22:26:09.624] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:13:0) after 6m16s
[22:32:25.640] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:13:0)
[22:32:25.667] Build status: STARTED
[22:32:25.667] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:14:0) after 2m29s
[22:34:54.692] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:14:0)
[22:34:54.711] Build status: STARTED
[22:34:54.711] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:15:0) after 5m13s
[22:40:07.732] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:15:0)
[22:40:07.752] Build status: STARTED
[22:40:07.752] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:16:0) after 7m22s
[22:47:30.001] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:16:0)
[22:47:30.023] Build status: STARTED
[22:47:30.023] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:17:0) after 2m48s
[22:50:18.419] Handling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:17:0)
[22:50:18.511] Build status: STARTED
[22:50:18.511] Scheduling timer "check-buildbucket-build-status" (chromium/WebKit Win10:8919337209378756032:18:0) after 7m32s
[22:52:17.269] Received PubSub notification, asking Buildbucket for the build status
[22:52:17.337] Build:
{
"id": "8753907147213728001",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "WebKit Win10"
},
"number": 130526,
"createdBy": "project:chromium",
"createTime": "2024-03-09T21:43:27.705228101Z",
"startTime": "2024-03-09T21:52:58.869290899Z",
"endTime": "2024-03-09T22:52:16.745273Z",
"updateTime": "2024-03-09T22:52:16.745273Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e1b6bfe2c785938af4676f803512e9cf4789d85c",
"ref": "refs/heads/main"
}
}
}
[22:52:17.337] Invocation finished in 1h8m51.081924741s with status SUCCEEDED