[15:21:06.566] New invocation is queued and will start shortly
[15:21:06.566] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[15:21:07.694] Starting the invocation (attempt 1)
[15:21:07.721] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c9bca7989b9177370054fac3fa370255430c8ffd"
[15:21:07.721] Popped gitiles commit info from properties and tags
[15:21:07.721] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:21:07.721] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:21:07.721] Buildbucket request:
{
"requestId": "8901604257987105600",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win11-updater-tester-dbg-uac"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "c9bca7989b9177370054fac3fa370255430c8ffd",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "c9bca7989b9177370054fac3fa370255430c8ffd"
},
"parent_build_id": "8736175312949156145",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win-updater-builder-dbg",
"parent_got_angle_revision": "167b9e8d2243e68f611ebdd837bd7af498025dc7",
"parent_got_dawn_revision": "aebc7be46ec601333832bc14256242f3280bbbd1",
"parent_got_revision": "c9bca7989b9177370054fac3fa370255430c8ffd",
"parent_got_revision_cp": "refs/heads/main@{#1358559}",
"parent_got_swiftshader_revision": "2afc8c97882a5c66abf5f26670ae420d2e30adc3",
"parent_got_v8_revision": "b136c5847b70679f04ed56f197c6359b5281230d",
"parent_got_v8_revision_cp": "refs/heads/13.1.67@{#1}",
"parent_got_webrtc_revision": "76821c85eb45b618bd00ad82363a65ce3fa6f14a",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#43063}",
"swarm_hashes": {
"updater_tests": "0acc746ea45899ae7c83b9575576eb33afe49ab5232cc855533d5a18680da310/565",
"updater_tests_system": "87a4e75d54bf23fc4b9a5fb4241d76c3fb9849b237a01cb939e0f2a489831101/565",
"updater_tests_win_uac": "6bbf45473e2a19f82e32dbcca8133057be1c61abdc71b438d8d864e5a120d446/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "04644b3725667de8322112c049e098c517856de3e0dd50fcb242162058d8e657/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c9bca7989b9177370054fac3fa370255430c8ffd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901604257987105600"
},
{
"key": "scheduler_job_id",
"value": "chromium/win11-updater-tester-dbg-uac"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "win-updater-builder-dbg"
},
{
"key": "parent_buildnumber",
"value": "143179"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:21:08.431] Scheduled build:
{
"id": "8736174195998338465",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win11-updater-tester-dbg-uac"
},
"number": 64703,
"createdBy": "project:chromium",
"createTime": "2024-09-21T15:21:07.833170923Z",
"updateTime": "2024-09-21T15:21:07.833170923Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c9bca7989b9177370054fac3fa370255430c8ffd",
"ref": "refs/heads/main"
}
}
}
[15:21:08.431] Task URL: https://cr-buildbucket.appspot.com/build/8736174195998338465
[15:21:08.432] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:2:0) after 2m9s
[15:21:09.363] Received PubSub notification, asking Buildbucket for the build status
[15:21:09.392] Build status: SCHEDULED
[15:23:17.446] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:2:0)
[15:23:17.471] Build status: SCHEDULED
[15:23:17.471] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:4:0) after 4m5s
[15:27:22.488] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:4:0)
[15:27:22.505] Build status: SCHEDULED
[15:27:22.505] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:5:0) after 1m17s
[15:28:39.551] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:5:0)
[15:28:39.574] Build status: SCHEDULED
[15:28:39.574] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:6:0) after 4m16s
[15:29:09.473] Received PubSub notification, asking Buildbucket for the build status
[15:29:09.500] Build status: STARTED
[15:32:55.694] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:6:0)
[15:32:55.719] Build status: STARTED
[15:32:55.719] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:8:0) after 2m5s
[15:35:00.736] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:8:0)
[15:35:00.844] Build status: STARTED
[15:35:00.844] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:9:0) after 4m46s
[15:39:47.149] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:9:0)
[15:39:47.165] Build status: STARTED
[15:39:47.165] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:10:0) after 2m30s
[15:42:17.313] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:10:0)
[15:42:17.342] Build status: STARTED
[15:42:17.342] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:11:0) after 7m34s
[15:49:51.384] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:11:0)
[15:49:51.405] Build status: STARTED
[15:49:51.405] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:12:0) after 1m32s
[15:51:23.423] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:12:0)
[15:51:23.442] Build status: STARTED
[15:51:23.442] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:13:0) after 6m1s
[15:57:24.734] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:13:0)
[15:57:24.755] Build status: STARTED
[15:57:24.755] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:14:0) after 6m28s
[16:03:52.778] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:14:0)
[16:03:52.796] Build status: STARTED
[16:03:52.796] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:15:0) after 2m17s
[16:06:09.811] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:15:0)
[16:06:09.832] Build status: STARTED
[16:06:09.832] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:16:0) after 2m14s
[16:08:23.961] Handling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:16:0)
[16:08:24.032] Build status: STARTED
[16:08:24.032] Scheduling timer "check-buildbucket-build-status" (chromium/win11-updater-tester-dbg-uac:8901604257987105600:17:0) after 8m28s
[16:11:04.773] Received PubSub notification, asking Buildbucket for the build status
[16:11:04.794] Build:
{
"id": "8736174195998338465",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win11-updater-tester-dbg-uac"
},
"number": 64703,
"createdBy": "project:chromium",
"createTime": "2024-09-21T15:21:07.833170923Z",
"startTime": "2024-09-21T15:29:09.274309368Z",
"endTime": "2024-09-21T16:11:04.407676403Z",
"updateTime": "2024-09-21T16:11:04.407676403Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c9bca7989b9177370054fac3fa370255430c8ffd",
"ref": "refs/heads/main"
}
}
}
[16:11:04.794] Invocation finished in 49m58.240404782s with status SUCCEEDED