[02:44:56.668] New invocation is queued and will start shortly
[02:44:56.668] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[02:44:57.766] Starting the invocation (attempt 1)
[02:44:57.796] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9a1d37e063c23debd8ec9ea58dabe06cc7e45e9e"
[02:44:57.796] Popped gitiles commit info from properties and tags
[02:44:57.796] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:44:57.796] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:44:57.796] Buildbucket request:
{
"requestId": "8929374503487345504",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "9a1d37e063c23debd8ec9ea58dabe06cc7e45e9e",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "9a1d37e063c23debd8ec9ea58dabe06cc7e45e9e"
},
"parent_build_id": "8763945067929433713",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win32-updater-builder-dbg",
"parent_got_angle_revision": "98d79260fa0ebfcd5a4d959c9c21bf44071a00e6",
"parent_got_dawn_revision": "bfb695dd9b62203f1b8fdaf7998e5681c38bd3b9",
"parent_got_revision": "9a1d37e063c23debd8ec9ea58dabe06cc7e45e9e",
"parent_got_revision_cp": "refs/heads/main@{#1226653}",
"parent_got_swiftshader_revision": "50dbfc35468c1ffa037e3e90bc71327d16a5e0cc",
"parent_got_v8_revision": "324cc1f85e9fb53da25afa270d6353a2167c9c96",
"parent_got_v8_revision_cp": "refs/heads/12.1.162@{#1}",
"parent_got_webrtc_revision": "0967247662f6de824432992a7cc5e154e0fd6c29",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41187}",
"swarm_hashes": {
"updater_tests": "29b67678acdf88b69698f0e1c69f9d164e3f641dff57c4a9b0388e7cf53880ad/565",
"updater_tests_system": "f4c86f30912433a148a8ddae99ea04b139dd6bf171688a74050506f4b6fbeb35/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "a1fec6b6104ff15529cb6cb2e3066c9931580e74dee8f2ba51deef9bc773e7eb/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9a1d37e063c23debd8ec9ea58dabe06cc7e45e9e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8929374503487345504"
},
{
"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": "77558"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:44:58.687] Scheduled build:
{
"id": "8763944441498532097",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"number": 33998,
"createdBy": "project:chromium",
"createTime": "2023-11-20T02:44:57.939473733Z",
"updateTime": "2023-11-20T02:44:57.939473733Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9a1d37e063c23debd8ec9ea58dabe06cc7e45e9e",
"ref": "refs/heads/main"
}
}
}
[02:44:58.687] Task URL: https://cr-buildbucket.appspot.com/build/8763944441498532097
[02:44:58.687] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:2:0) after 5m11s
[02:44:59.601] Received PubSub notification, asking Buildbucket for the build status
[02:44:59.743] Build status: SCHEDULED
[02:45:00.168] Received PubSub notification, asking Buildbucket for the build status
[02:45:00.201] Build status: STARTED
[02:50:09.714] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:2:0)
[02:50:09.738] Build status: STARTED
[02:50:09.738] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:5:0) after 2m31s
[02:52:40.769] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:5:0)
[02:52:40.787] Build status: STARTED
[02:52:40.787] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:6:0) after 7m49s
[03:00:29.871] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:6:0)
[03:00:29.910] Build status: STARTED
[03:00:29.910] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:7:0) after 1m16s
[03:01:46.265] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:7:0)
[03:01:46.295] Build status: STARTED
[03:01:46.295] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:8:0) after 1m14s
[03:03:00.314] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:8:0)
[03:03:00.382] Build status: STARTED
[03:03:00.382] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:9:0) after 7m58s
[03:10:58.443] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:9:0)
[03:10:58.461] Build status: STARTED
[03:10:58.461] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8929374503487345504:10:0) after 7m43s
[03:14:39.472] Received PubSub notification, asking Buildbucket for the build status
[03:14:39.499] Build:
{
"id": "8763944441498532097",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"number": 33998,
"createdBy": "project:chromium",
"createTime": "2023-11-20T02:44:57.939473733Z",
"startTime": "2023-11-20T02:44:59.716115Z",
"endTime": "2023-11-20T03:14:33.739912Z",
"updateTime": "2023-11-20T03:14:33.739912Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9a1d37e063c23debd8ec9ea58dabe06cc7e45e9e",
"ref": "refs/heads/main"
}
}
}
[03:14:39.499] Invocation finished in 29m42.839448669s with status SUCCEEDED