[06:09:02.979] New invocation is queued and will start shortly
[06:09:02.979] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[06:09:04.142] Starting the invocation (attempt 1)
[06:09:04.167] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7e1d2e6c11375f1a69cf7b7424fd2b2a8eef6c7"
[06:09:04.167] Popped gitiles commit info from properties and tags
[06:09:04.167] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:09:04.167] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:09:04.168] Buildbucket request:
{
"requestId": "8931535989521878832",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "e7e1d2e6c11375f1a69cf7b7424fd2b2a8eef6c7",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "e7e1d2e6c11375f1a69cf7b7424fd2b2a8eef6c7"
},
"parent_build_id": "8766106941285418833",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win32-updater-builder-dbg",
"parent_got_angle_revision": "3596ab4c01d361aaa66360692a132efc60db811b",
"parent_got_dawn_revision": "fd22bd69eb33bb2fcfd2bb5cd5dacfef3cb345cc",
"parent_got_revision": "e7e1d2e6c11375f1a69cf7b7424fd2b2a8eef6c7",
"parent_got_revision_cp": "refs/heads/main@{#1215957}",
"parent_got_swiftshader_revision": "d9ec9befba05a8dfca09c1e88f3f7be0e4b153c6",
"parent_got_v8_revision": "b3cb0818156bed06f359c96d274ec5db90bd7699",
"parent_got_v8_revision_cp": "refs/heads/12.0.245@{#1}",
"parent_got_webrtc_revision": "2e1f16d55c66ded230db084cdd517a9b9dfb21bc",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41014}",
"swarm_hashes": {
"updater_tests": "a8be61d4d0009ca1c80eb720dfd72b56c223ba14943eea82ec3de8b6a5fa0a4e/565",
"updater_tests_system": "764a733713bb18039b60009646f1dfe335c2c2dff46fbdc1c2fd567b8bd408a6/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "a1fec6b6104ff15529cb6cb2e3066c9931580e74dee8f2ba51deef9bc773e7eb/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e7e1d2e6c11375f1a69cf7b7424fd2b2a8eef6c7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931535989521878832"
},
{
"key": "scheduler_job_id",
"value": "chromium/win10-32-on-64-updater-tester-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "win32-updater-builder-dbg"
},
{
"key": "parent_buildnumber",
"value": "74481"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:09:04.962] Scheduled build:
{
"id": "8766105927496463297",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"number": 32894,
"createdBy": "project:chromium",
"createTime": "2023-10-27T06:09:04.258443610Z",
"updateTime": "2023-10-27T06:09:04.258443610Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e7e1d2e6c11375f1a69cf7b7424fd2b2a8eef6c7",
"ref": "refs/heads/main"
}
}
}
[06:09:04.962] Task URL: https://cr-buildbucket.appspot.com/build/8766105927496463297
[06:09:04.962] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:2:0) after 4m58s
[06:09:05.402] Received PubSub notification, asking Buildbucket for the build status
[06:09:05.428] Build status: SCHEDULED
[06:09:09.604] Received PubSub notification, asking Buildbucket for the build status
[06:09:09.622] Build status: STARTED
[06:14:03.102] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:2:0)
[06:14:03.165] Build status: STARTED
[06:14:03.165] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:5:0) after 4m15s
[06:18:18.319] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:5:0)
[06:18:18.340] Build status: STARTED
[06:18:18.340] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:6:0) after 2m55s
[06:21:13.391] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:6:0)
[06:21:13.412] Build status: STARTED
[06:21:13.413] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:7:0) after 4m23s
[06:25:36.433] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:7:0)
[06:25:36.461] Build status: STARTED
[06:25:36.461] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:8:0) after 1m16s
[06:26:52.936] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:8:0)
[06:26:52.952] Build status: STARTED
[06:26:52.952] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:9:0) after 3m8s
[06:30:01.258] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:9:0)
[06:30:01.288] Build status: STARTED
[06:30:01.288] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8931535989521878832:10:0) after 6m42s
[06:32:18.835] Received PubSub notification, asking Buildbucket for the build status
[06:32:18.867] Build:
{
"id": "8766105927496463297",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"number": 32894,
"createdBy": "project:chromium",
"createTime": "2023-10-27T06:09:04.258443610Z",
"startTime": "2023-10-27T06:09:07.774383Z",
"endTime": "2023-10-27T06:32:18.488962532Z",
"updateTime": "2023-10-27T06:32:18.488962532Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e7e1d2e6c11375f1a69cf7b7424fd2b2a8eef6c7",
"ref": "refs/heads/main"
}
}
}
[06:32:18.867] Invocation finished in 23m15.924746838s with status SUCCEEDED