[20:51:22.514] New invocation is queued and will start shortly
[20:51:22.514] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[20:51:23.555] Starting the invocation (attempt 1)
[20:51:23.580] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6086218f89d3060f027ed3decd7de428fc98d039"
[20:51:23.580] Popped gitiles commit info from properties and tags
[20:51:23.580] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:51:23.580] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:51:23.581] Buildbucket request:
{
"requestId": "8929577942078741184",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "6086218f89d3060f027ed3decd7de428fc98d039",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "6086218f89d3060f027ed3decd7de428fc98d039"
},
"parent_build_id": "8764148559073879761",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win-updater-builder-dbg",
"parent_got_angle_revision": "6d50433c432b59a77773ccd2b757f09858a51093",
"parent_got_dawn_revision": "ea3f32389555523e73e07f0f3ffea405af77c6a1",
"parent_got_revision": "6086218f89d3060f027ed3decd7de428fc98d039",
"parent_got_revision_cp": "refs/heads/main@{#1226315}",
"parent_got_swiftshader_revision": "50dbfc35468c1ffa037e3e90bc71327d16a5e0cc",
"parent_got_v8_revision": "1c1865bf8ec02cbc73a033f3fdf64fb09ce2970e",
"parent_got_v8_revision_cp": "refs/heads/12.1.153@{#1}",
"parent_got_webrtc_revision": "0967247662f6de824432992a7cc5e154e0fd6c29",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41187}",
"swarm_hashes": {
"updater_tests": "e00b673643aeabadfd7081a88edfd07a8c1383b65d15266e1f9e96e4cc28898c/565",
"updater_tests_system": "017eb46f4e28dad6fa26d35eaf21f04be4079cc752f96b3a3708df60646854de/565",
"updater_tests_win_uac": "e2e8f69bcfc5f99511aaac9df08ea2e98c4f58e5896a5e603e1f6cf68d0566d9/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "04644b3725667de8322112c049e098c517856de3e0dd50fcb242162058d8e657/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6086218f89d3060f027ed3decd7de428fc98d039",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8929577942078741184"
},
{
"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": "97012"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:51:24.114] Scheduled build:
{
"id": "8764147880234891905",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 71533,
"createdBy": "project:chromium",
"createTime": "2023-11-17T20:51:23.641111515Z",
"updateTime": "2023-11-17T20:51:23.641111515Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6086218f89d3060f027ed3decd7de428fc98d039",
"ref": "refs/heads/main"
}
}
}
[20:51:24.114] Task URL: https://cr-buildbucket.appspot.com/build/8764147880234891905
[20:51:24.114] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:2:0) after 3m42s
[20:51:25.082] Received PubSub notification, asking Buildbucket for the build status
[20:51:25.103] Build status: SCHEDULED
[20:51:25.959] Received PubSub notification, asking Buildbucket for the build status
[20:51:25.984] Build status: STARTED
[20:55:06.131] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:2:0)
[20:55:06.150] Build status: STARTED
[20:55:06.150] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:5:0) after 2m59s
[20:58:05.132] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:5:0)
[20:58:05.155] Build status: STARTED
[20:58:05.155] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:6:0) after 7m50s
[21:05:55.170] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:6:0)
[21:05:55.199] Build status: STARTED
[21:05:55.199] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:7:0) after 5m17s
[21:11:12.317] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:7:0)
[21:11:12.349] Build status: STARTED
[21:11:12.349] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:8:0) after 4m35s
[21:15:47.759] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:8:0)
[21:15:47.781] Build status: STARTED
[21:15:47.781] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8929577942078741184:9:0) after 7m6s
[21:20:58.581] Received PubSub notification, asking Buildbucket for the build status
[21:20:58.605] Build:
{
"id": "8764147880234891905",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 71533,
"createdBy": "project:chromium",
"createTime": "2023-11-17T20:51:23.641111515Z",
"startTime": "2023-11-17T20:51:25.375797Z",
"endTime": "2023-11-17T21:20:57.084295Z",
"updateTime": "2023-11-17T21:20:57.084295Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6086218f89d3060f027ed3decd7de428fc98d039",
"ref": "refs/heads/main"
}
}
}
[21:20:58.605] Invocation finished in 29m36.105819909s with status SUCCEEDED