[13:34:04.163] New invocation is queued and will start shortly
[13:34:04.163] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[13:34:05.324] Starting the invocation (attempt 1)
[13:34:05.355] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ba754825f5d4453ba209a41e3a08cc53e50c48b6"
[13:34:05.355] Popped gitiles commit info from properties and tags
[13:34:05.355] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:34:05.355] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:34:05.355] Buildbucket request:
{
"requestId": "8928699485323433312",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "ba754825f5d4453ba209a41e3a08cc53e50c48b6",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "ba754825f5d4453ba209a41e3a08cc53e50c48b6"
},
"parent_build_id": "8763270860819646609",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win-updater-builder-dbg",
"parent_got_angle_revision": "ea8238935e4db0ec0d67460d402b1866d3f9ef26",
"parent_got_dawn_revision": "571cc4420ff93b2ff9ed49ef2c076191563c87df",
"parent_got_revision": "ba754825f5d4453ba209a41e3a08cc53e50c48b6",
"parent_got_revision_cp": "refs/heads/main@{#1229270}",
"parent_got_swiftshader_revision": "50dbfc35468c1ffa037e3e90bc71327d16a5e0cc",
"parent_got_v8_revision": "f74711162b9afb08813f57e43d8468b2e498b85e",
"parent_got_v8_revision_cp": "refs/heads/12.1.226@{#1}",
"parent_got_webrtc_revision": "d0f0f38f72d92e603e909f8ef09d4f538c1aa2c7",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41244}",
"swarm_hashes": {
"updater_tests": "31fadf5fc30fe80c020c47d9bea32db4a65369408a23f86115af20fb0436b82c/565",
"updater_tests_system": "09c27c4cc997a4ee76b8783ce64c72ef145c34e176cd18253feb4d82e3336192/565",
"updater_tests_win_uac": "a62280691843793bdbf2af752567e842fa113c3163616fab8f621876d0d8929b/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "04644b3725667de8322112c049e098c517856de3e0dd50fcb242162058d8e657/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ba754825f5d4453ba209a41e3a08cc53e50c48b6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8928699485323433312"
},
{
"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": "98013"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:34:05.971] Scheduled build:
{
"id": "8763269423341656209",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 71923,
"createdBy": "project:chromium",
"createTime": "2023-11-27T13:34:05.418485368Z",
"updateTime": "2023-11-27T13:34:05.418485368Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ba754825f5d4453ba209a41e3a08cc53e50c48b6",
"ref": "refs/heads/main"
}
}
}
[13:34:05.971] Task URL: https://cr-buildbucket.appspot.com/build/8763269423341656209
[13:34:05.971] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:2:0) after 4m26s
[13:34:06.497] Received PubSub notification, asking Buildbucket for the build status
[13:34:06.630] Build status: SCHEDULED
[13:34:09.381] Received PubSub notification, asking Buildbucket for the build status
[13:34:09.453] Build status: STARTED
[13:38:32.084] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:2:0)
[13:38:32.106] Build status: STARTED
[13:38:32.106] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:5:0) after 4m7s
[13:42:39.120] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:5:0)
[13:42:39.140] Build status: STARTED
[13:42:39.140] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:6:0) after 8m1s
[13:50:40.580] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:6:0)
[13:50:40.608] Build status: STARTED
[13:50:40.608] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:7:0) after 1m14s
[13:51:54.846] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:7:0)
[13:51:54.914] Build status: STARTED
[13:51:54.914] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:8:0) after 8m53s
[14:00:47.935] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:8:0)
[14:00:47.976] Build status: STARTED
[14:00:47.976] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8928699485323433312:9:0) after 1m55s
[14:01:57.830] Received PubSub notification, asking Buildbucket for the build status
[14:01:57.904] Build:
{
"id": "8763269423341656209",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 71923,
"createdBy": "project:chromium",
"createTime": "2023-11-27T13:34:05.418485368Z",
"startTime": "2023-11-27T13:34:08.174622Z",
"endTime": "2023-11-27T14:01:57.186659Z",
"updateTime": "2023-11-27T14:01:57.186659Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ba754825f5d4453ba209a41e3a08cc53e50c48b6",
"ref": "refs/heads/main"
}
}
}
[14:01:57.904] Invocation finished in 27m53.759051425s with status SUCCEEDED