[03:20:25.052] New invocation is queued and will start shortly
[03:20:25.052] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[03:20:26.122] Starting the invocation (attempt 1)
[03:20:26.148] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1387fe17664b15989457d0a012fce28293486a0b"
[03:20:26.148] Popped gitiles commit info from properties and tags
[03:20:26.148] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:20:26.148] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:20:26.148] Buildbucket request:
{
"requestId": "8924389438557587968",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "1387fe17664b15989457d0a012fce28293486a0b",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "1387fe17664b15989457d0a012fce28293486a0b"
},
"parent_build_id": "8758960817826454993",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win-updater-builder-dbg",
"parent_got_angle_revision": "572323ccbba5ae703e1a2e8c088d638b896e0dee",
"parent_got_dawn_revision": "33ffb3786277319c85806c06fcf51a6fbbb21aee",
"parent_got_revision": "1387fe17664b15989457d0a012fce28293486a0b",
"parent_got_revision_cp": "refs/heads/main@{#1246903}",
"parent_got_swiftshader_revision": "2fa7e9b99ae4e70ea5ae2cc9c8d3afb43391384f",
"parent_got_v8_revision": "59e17e84e5034d92fba3d6e956e317f1b32c13ea",
"parent_got_v8_revision_cp": "refs/heads/12.2.238@{#1}",
"parent_got_webrtc_revision": "f8587da72b065606a1b5e2074f628f9cc1473604",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41520}",
"swarm_hashes": {
"updater_tests": "7dffe4730467e2e6bf4f773528a973af641f332aa4b76624cb3da379d6e7921e/565",
"updater_tests_system": "1ac3fd42cde2e621fe6ee0615140c06f5798d6d4aa187cbb8c9b96d8b82b41ea/565",
"updater_tests_win_uac": "81dca5a02ed0d76c2fd4e6a7cf78f8562129843f9fa5c8e47ef5e76231a5f7ce/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "04644b3725667de8322112c049e098c517856de3e0dd50fcb242162058d8e657/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1387fe17664b15989457d0a012fce28293486a0b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8924389438557587968"
},
{
"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": "104079"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:20:26.899] Scheduled build:
{
"id": "8758959376692069985",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 76193,
"createdBy": "project:chromium",
"createTime": "2024-01-14T03:20:26.211316793Z",
"updateTime": "2024-01-14T03:20:26.211316793Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1387fe17664b15989457d0a012fce28293486a0b",
"ref": "refs/heads/main"
}
}
}
[03:20:26.899] Task URL: https://cr-buildbucket.appspot.com/build/8758959376692069985
[03:20:26.899] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:2:0) after 1m43s
[03:20:27.790] Received PubSub notification, asking Buildbucket for the build status
[03:20:27.826] Build status: SCHEDULED
[03:22:09.934] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:2:0)
[03:22:09.965] Build status: SCHEDULED
[03:22:09.965] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:4:0) after 4m59s
[03:27:09.140] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:4:0)
[03:27:09.195] Build status: SCHEDULED
[03:27:09.195] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:5:0) after 1m2s
[03:28:11.259] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:5:0)
[03:28:11.291] Build status: SCHEDULED
[03:28:11.291] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:6:0) after 1m0s
[03:29:11.358] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:6:0)
[03:29:11.395] Build status: SCHEDULED
[03:29:11.395] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:7:0) after 2m33s
[03:31:44.422] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:7:0)
[03:31:44.445] Build status: SCHEDULED
[03:31:44.445] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:8:0) after 1m24s
[03:33:08.458] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:8:0)
[03:33:08.475] Build status: SCHEDULED
[03:33:08.475] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:9:0) after 4m10s
[03:37:03.287] Received PubSub notification, asking Buildbucket for the build status
[03:37:03.313] Build status: STARTED
[03:37:18.491] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:9:0)
[03:37:18.528] Build status: STARTED
[03:37:18.528] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:11:0) after 1m25s
[03:38:43.636] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:11:0)
[03:38:43.653] Build status: STARTED
[03:38:43.653] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:12:0) after 2m42s
[03:41:25.707] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:12:0)
[03:41:25.783] Build status: STARTED
[03:41:25.783] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:13:0) after 8m46s
[03:50:11.799] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:13:0)
[03:50:11.827] Build status: STARTED
[03:50:11.827] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8924389438557587968:14:0) after 7m19s
[03:50:39.749] Received PubSub notification, asking Buildbucket for the build status
[03:50:39.767] Build:
{
"id": "8758959376692069985",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 76193,
"createdBy": "project:chromium",
"createTime": "2024-01-14T03:20:26.211316793Z",
"startTime": "2024-01-14T03:37:02.270133Z",
"endTime": "2024-01-14T03:50:39.233724Z",
"updateTime": "2024-01-14T03:50:39.233724Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1387fe17664b15989457d0a012fce28293486a0b",
"ref": "refs/heads/main"
}
}
}
[03:50:39.767] Invocation finished in 30m14.718975847s with status SUCCEEDED