[02:22:36.449] New invocation is queued and will start shortly
[02:22:36.449] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[02:22:37.538] Starting the invocation (attempt 1)
[02:22:37.563] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5af81b8a1b72f4d7e752dad31c506d5d29a23ea7"
[02:22:37.563] Popped gitiles commit info from properties and tags
[02:22:37.563] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:22:37.563] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:22:37.563] Buildbucket request:
{
"requestId": "8914155618453870384",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "5af81b8a1b72f4d7e752dad31c506d5d29a23ea7",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "5af81b8a1b72f4d7e752dad31c506d5d29a23ea7"
},
"parent_build_id": "8748725907113234657",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win32-updater-builder-dbg",
"parent_got_angle_revision": "465f6b7d2f3b4928cfe422d1cdd59b7aab1e2102",
"parent_got_dawn_revision": "b3007ae198793391e94799b6953048eb42218236",
"parent_got_revision": "5af81b8a1b72f4d7e752dad31c506d5d29a23ea7",
"parent_got_revision_cp": "refs/heads/main@{#1296676}",
"parent_got_swiftshader_revision": "76f7f8cfea80d26fa41d51f52cfbade49ec1f838",
"parent_got_v8_revision": "e6d52a000f69b64a37d1d025c90a1dfa5d57330f",
"parent_got_v8_revision_cp": "refs/heads/12.6.156@{#1}",
"parent_got_webrtc_revision": "a2e33ed8808384ed46adb5ee3e0f8a2932645655",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#42228}",
"swarm_hashes": {
"updater_tests": "f300e62d4d48d86bfd7b7597401b304edbf2a76fdf57310ed752699f7f71cdc9/565",
"updater_tests_system": "992b2948bcb0f1e49ea643aeb9e2f2fd360e966cdf98877707cabc94339689c7/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "a1fec6b6104ff15529cb6cb2e3066c9931580e74dee8f2ba51deef9bc773e7eb/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5af81b8a1b72f4d7e752dad31c506d5d29a23ea7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914155618453870384"
},
{
"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": "101624"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:22:38.279] Scheduled build:
{
"id": "8748725556482058289",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"number": 51223,
"createdBy": "project:chromium",
"createTime": "2024-05-06T02:22:37.704652588Z",
"updateTime": "2024-05-06T02:22:37.704652588Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5af81b8a1b72f4d7e752dad31c506d5d29a23ea7",
"ref": "refs/heads/main"
}
}
}
[02:22:38.279] Task URL: https://cr-buildbucket.appspot.com/build/8748725556482058289
[02:22:38.279] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:2:0) after 6m49s
[02:22:39.201] Received PubSub notification, asking Buildbucket for the build status
[02:22:39.250] Build status: SCHEDULED
[02:26:45.377] Received PubSub notification, asking Buildbucket for the build status
[02:26:45.399] Build status: STARTED
[02:29:27.296] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:2:0)
[02:29:27.320] Build status: STARTED
[02:29:27.320] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:5:0) after 3m9s
[02:32:36.443] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:5:0)
[02:32:36.470] Build status: STARTED
[02:32:36.471] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:6:0) after 3m29s
[02:36:05.486] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:6:0)
[02:36:05.504] Build status: STARTED
[02:36:05.504] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:7:0) after 1m26s
[02:37:31.492] Handling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:7:0)
[02:37:31.515] Build status: STARTED
[02:37:31.515] Scheduling timer "check-buildbucket-build-status" (chromium/win10-32-on-64-updater-tester-dbg:8914155618453870384:8:0) after 9m40s
[02:40:01.325] Received PubSub notification, asking Buildbucket for the build status
[02:40:01.392] Build:
{
"id": "8748725556482058289",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-32-on-64-updater-tester-dbg"
},
"number": 51223,
"createdBy": "project:chromium",
"createTime": "2024-05-06T02:22:37.704652588Z",
"startTime": "2024-05-06T02:26:45.180263305Z",
"endTime": "2024-05-06T02:40:00.605595691Z",
"updateTime": "2024-05-06T02:40:00.605595691Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5af81b8a1b72f4d7e752dad31c506d5d29a23ea7",
"ref": "refs/heads/main"
}
}
}
[02:40:01.392] Invocation finished in 17m24.952578044s with status SUCCEEDED