[22:16:01.473] New invocation is queued and will start shortly
[22:16:01.473] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[22:16:02.574] Starting the invocation (attempt 1)
[22:16:02.618] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a961b618377cdfc062ed07b4d2c0ef7d324b6a65"
[22:16:02.618] Popped gitiles commit info from properties and tags
[22:16:02.618] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:16:02.618] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:16:02.619] Buildbucket request:
{
"requestId": "8914442923015286880",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "a961b618377cdfc062ed07b4d2c0ef7d324b6a65",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "a961b618377cdfc062ed07b4d2c0ef7d324b6a65"
},
"parent_build_id": "8749013320675844801",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win-updater-builder-dbg",
"parent_got_angle_revision": "f2182a713e7b796ed4e4552d829db2ddfad2445f",
"parent_got_dawn_revision": "eae2d291b7270697906f790665cccb3c2bd3c2f9",
"parent_got_revision": "a961b618377cdfc062ed07b4d2c0ef7d324b6a65",
"parent_got_revision_cp": "refs/heads/main@{#1295786}",
"parent_got_swiftshader_revision": "76f7f8cfea80d26fa41d51f52cfbade49ec1f838",
"parent_got_v8_revision": "6ff76cd7fed789c6f6b6eaae1fccc6c85cbdf5e4",
"parent_got_v8_revision_cp": "refs/heads/12.6.151@{#1}",
"parent_got_webrtc_revision": "81eca8306bf7ae4ce589951f539e291372fcea95",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#42213}",
"swarm_hashes": {
"updater_tests": "e9ef27f6066146d4cc3768589a30d62cbc3863b6512e5d0a3cb89ca68630eb68/565",
"updater_tests_system": "10f4a93caf2cf928702faba0846eb1007626a765986be1f2942f7b5b4f55d93b/565",
"updater_tests_win_uac": "430f15b57dbc7754d3a5dd274297aec592208023a1c3612276a88ebd45dedb59/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "04644b3725667de8322112c049e098c517856de3e0dd50fcb242162058d8e657/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a961b618377cdfc062ed07b4d2c0ef7d324b6a65",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914442923015286880"
},
{
"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": "120745"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:16:03.315] Scheduled build:
{
"id": "8749012861022235649",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 88406,
"createdBy": "project:chromium",
"createTime": "2024-05-02T22:16:02.743390271Z",
"updateTime": "2024-05-02T22:16:02.743390271Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a961b618377cdfc062ed07b4d2c0ef7d324b6a65",
"ref": "refs/heads/main"
}
}
}
[22:16:03.315] Task URL: https://cr-buildbucket.appspot.com/build/8749012861022235649
[22:16:03.315] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:2:0) after 5m2s
[22:16:04.310] Received PubSub notification, asking Buildbucket for the build status
[22:16:04.467] Build status: SCHEDULED
[22:16:11.632] Received PubSub notification, asking Buildbucket for the build status
[22:16:11.651] Build status: STARTED
[22:21:05.412] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:2:0)
[22:21:05.445] Build status: STARTED
[22:21:05.445] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:5:0) after 4m44s
[22:25:49.505] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:5:0)
[22:25:49.533] Build status: STARTED
[22:25:49.533] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:6:0) after 5m26s
[22:31:15.574] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:6:0)
[22:31:15.595] Build status: STARTED
[22:31:15.595] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:7:0) after 3m8s
[22:34:23.589] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:7:0)
[22:34:23.606] Build status: STARTED
[22:34:23.606] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:8:0) after 3m0s
[22:37:23.684] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:8:0)
[22:37:23.702] Build status: STARTED
[22:37:23.702] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:9:0) after 1m55s
[22:39:18.750] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:9:0)
[22:39:18.864] Build status: STARTED
[22:39:18.864] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:10:0) after 1m43s
[22:41:01.991] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:10:0)
[22:41:02.049] Build status: STARTED
[22:41:02.049] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:11:0) after 1m19s
[22:42:21.118] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:11:0)
[22:42:21.224] Build status: STARTED
[22:42:21.225] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8914442923015286880:12:0) after 2m34s
[22:44:35.275] Received PubSub notification, asking Buildbucket for the build status
[22:44:35.303] Build:
{
"id": "8749012861022235649",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 88406,
"createdBy": "project:chromium",
"createTime": "2024-05-02T22:16:02.743390271Z",
"startTime": "2024-05-02T22:16:11.364959453Z",
"endTime": "2024-05-02T22:44:34.613752886Z",
"updateTime": "2024-05-02T22:44:34.613752886Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a961b618377cdfc062ed07b4d2c0ef7d324b6a65",
"ref": "refs/heads/main"
}
}
}
[22:44:35.303] Invocation finished in 28m33.845123555s with status SUCCEEDED