[12:19:24.870] New invocation is queued and will start shortly
[12:19:24.870] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[12:19:26.297] Starting the invocation (attempt 1)
[12:19:26.324] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0faf833a3f584b5f17188fb228ef166c3e8c1cc8"
[12:19:26.324] Popped gitiles commit info from properties and tags
[12:19:26.324] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:19:26.324] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:19:26.325] Buildbucket request:
{
"requestId": "8916382994812408112",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "0faf833a3f584b5f17188fb228ef166c3e8c1cc8",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "0faf833a3f584b5f17188fb228ef166c3e8c1cc8"
},
"parent_build_id": "8750953521298927937",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win-updater-builder-dbg",
"parent_got_angle_revision": "e41286e1092c950b64a6e6c6a46eb7c716d8a3a9",
"parent_got_dawn_revision": "ac32331dc38a0d78bc2a7fd0e89a8e30db10d4ed",
"parent_got_revision": "0faf833a3f584b5f17188fb228ef166c3e8c1cc8",
"parent_got_revision_cp": "refs/heads/main@{#1285745}",
"parent_got_swiftshader_revision": "62c59c41e194c288c06739788bb0aad3c86b19bf",
"parent_got_v8_revision": "555084e67f98736a41e52d13e485ab0febc3cbae",
"parent_got_v8_revision_cp": "refs/heads/12.5.209@{#1}",
"parent_got_webrtc_revision": "f942a2901aa45546ec525c0adf977071f312f6f3",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#42038}",
"swarm_hashes": {
"updater_tests": "bf69d44c0082c8031d2c469d44b6cfaca5f2e08f0d0d6abc8b59ee2c06ac7b3a/565",
"updater_tests_system": "c9fe2456ef91efea388b42ae6cf4db2620109b813b6faaa9004585244f24f79b/565",
"updater_tests_win_uac": "7655bdff2092b2e3266db04f680bf71ebadc03e1da4c0d6df9639c72d5727815/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "04644b3725667de8322112c049e098c517856de3e0dd50fcb242162058d8e657/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0faf833a3f584b5f17188fb228ef166c3e8c1cc8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916382994812408112"
},
{
"key": "scheduler_job_id",
"value": "chromium/win10-updater-tester-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "win-updater-builder-dbg"
},
{
"key": "parent_buildnumber",
"value": "117193"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:19:27.262] Scheduled build:
{
"id": "8750952932429352097",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 85883,
"createdBy": "project:chromium",
"createTime": "2024-04-11T12:19:26.470006626Z",
"updateTime": "2024-04-11T12:19:26.470006626Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0faf833a3f584b5f17188fb228ef166c3e8c1cc8",
"ref": "refs/heads/main"
}
}
}
[12:19:27.262] Task URL: https://cr-buildbucket.appspot.com/build/8750952932429352097
[12:19:27.262] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:2:0) after 6m29s
[12:19:28.254] Received PubSub notification, asking Buildbucket for the build status
[12:19:28.283] Build status: SCHEDULED
[12:20:46.748] Received PubSub notification, asking Buildbucket for the build status
[12:20:46.771] Build status: STARTED
[12:25:56.394] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:2:0)
[12:25:56.423] Build status: STARTED
[12:25:56.423] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:5:0) after 2m18s
[12:28:14.530] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:5:0)
[12:28:14.587] Build status: STARTED
[12:28:14.587] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:6:0) after 8m39s
[12:36:53.694] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:6:0)
[12:36:53.729] Build status: STARTED
[12:36:53.729] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:7:0) after 9m8s
[12:46:01.980] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:7:0)
[12:46:02.072] Build status: STARTED
[12:46:02.072] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8916382994812408112:8:0) after 6m26s
[12:51:09.148] Received PubSub notification, asking Buildbucket for the build status
[12:51:09.200] Build:
{
"id": "8750952932429352097",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 85883,
"createdBy": "project:chromium",
"createTime": "2024-04-11T12:19:26.470006626Z",
"startTime": "2024-04-11T12:20:46.340918395Z",
"endTime": "2024-04-11T12:51:08.437346062Z",
"updateTime": "2024-04-11T12:51:08.437346062Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0faf833a3f584b5f17188fb228ef166c3e8c1cc8",
"ref": "refs/heads/main"
}
}
}
[12:51:09.200] Invocation finished in 31m44.386713573s with status SUCCEEDED