[05:38:44.827] New invocation is queued and will start shortly
[05:38:44.827] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[05:38:45.995] Starting the invocation (attempt 1)
[05:38:46.026] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cf925e36e0005589fa60ad9d5f72258e6066ffc9"
[05:38:46.026] Popped gitiles commit info from properties and tags
[05:38:46.026] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:38:46.027] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:38:46.028] Buildbucket request:
{
"requestId": "8928095211236828448",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "cf925e36e0005589fa60ad9d5f72258e6066ffc9",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "cf925e36e0005589fa60ad9d5f72258e6066ffc9"
},
"parent_build_id": "8762665678177854593",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win-updater-builder-dbg",
"parent_got_angle_revision": "fb6b960c0a737d20e9b6907a8da56343fd1fab08",
"parent_got_dawn_revision": "a598e5ffe1b7806d2d4df4373085687b54bcb42a",
"parent_got_revision": "cf925e36e0005589fa60ad9d5f72258e6066ffc9",
"parent_got_revision_cp": "refs/heads/main@{#1232565}",
"parent_got_swiftshader_revision": "4befa3ada54ce2fbdadb2383712da70811efe85e",
"parent_got_v8_revision": "b74ef6f2cd2fe60c91abcd3271b661547a47ca4f",
"parent_got_v8_revision_cp": "refs/heads/12.1.285@{#1}",
"parent_got_webrtc_revision": "8f530e8d7879b6399440e0b33f376268544e0df8",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41299}",
"swarm_hashes": {
"updater_tests": "146f59dc601e5a08e2de28b4bcd968e83403e58e3d71665d6170b70c3766f941/565",
"updater_tests_system": "61e2c0bf7c52d0e33685375f157ade189797648e26d88338bf57c43eb8258d36/565",
"updater_tests_win_uac": "86d241a2c0a50df4ef6430bd6720202155383596508c369a2fca9ed3f11e7c6f/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "04644b3725667de8322112c049e098c517856de3e0dd50fcb242162058d8e657/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cf925e36e0005589fa60ad9d5f72258e6066ffc9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8928095211236828448"
},
{
"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": "98905"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:38:46.733] Scheduled build:
{
"id": "8762665149271501937",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 72239,
"createdBy": "project:chromium",
"createTime": "2023-12-04T05:38:46.079851318Z",
"updateTime": "2023-12-04T05:38:46.079851318Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cf925e36e0005589fa60ad9d5f72258e6066ffc9",
"ref": "refs/heads/main"
}
}
}
[05:38:46.733] Task URL: https://cr-buildbucket.appspot.com/build/8762665149271501937
[05:38:46.733] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:2:0) after 1m12s
[05:38:47.560] Received PubSub notification, asking Buildbucket for the build status
[05:38:47.590] Build status: SCHEDULED
[05:38:49.861] Received PubSub notification, asking Buildbucket for the build status
[05:38:49.917] Build status: STARTED
[05:39:58.754] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:2:0)
[05:39:58.776] Build status: STARTED
[05:39:58.776] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:5:0) after 8m43s
[05:48:41.995] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:5:0)
[05:48:42.026] Build status: STARTED
[05:48:42.026] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:6:0) after 4m54s
[05:53:36.078] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:6:0)
[05:53:36.099] Build status: STARTED
[05:53:36.099] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:7:0) after 5m38s
[05:59:14.215] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:7:0)
[05:59:14.237] Build status: STARTED
[05:59:14.237] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928095211236828448:8:0) after 6m14s
[06:03:10.450] Received PubSub notification, asking Buildbucket for the build status
[06:03:10.468] Build:
{
"id": "8762665149271501937",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 72239,
"createdBy": "project:chromium",
"createTime": "2023-12-04T05:38:46.079851318Z",
"startTime": "2023-12-04T05:38:49.356475Z",
"endTime": "2023-12-04T06:03:09.794662Z",
"updateTime": "2023-12-04T06:03:09.794662Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cf925e36e0005589fa60ad9d5f72258e6066ffc9",
"ref": "refs/heads/main"
}
}
}
[06:03:10.468] Invocation finished in 24m25.647225617s with status SUCCEEDED