[13:44:09.258] New invocation is queued and will start shortly
[13:44:09.258] Triggered by user:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[13:44:10.361] Starting the invocation (attempt 1)
[13:44:10.388] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1e573402f388b25077009f05672e0c57375ed17"
[13:44:10.388] Popped gitiles commit info from properties and tags
[13:44:10.388] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:44:10.388] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:44:10.388] Buildbucket request:
{
"requestId": "8930782581055162832",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"properties": {
"$bootstrap/trigger": {
"commits": [
{
"host": "chromium.googlesource.com",
"id": "f1e573402f388b25077009f05672e0c57375ed17",
"project": "chromium/src",
"ref": "refs/heads/main"
}
]
},
"deps_revision_overrides": {
"src": "f1e573402f388b25077009f05672e0c57375ed17"
},
"parent_build_id": "8765355315155282081",
"parent_builder_group": "chromium.updater",
"parent_buildername": "win-updater-builder-dbg",
"parent_got_angle_revision": "ae3af8ee0c586fe4e8b6838a60d3066221710828",
"parent_got_dawn_revision": "a720baaadb53cf57f992295c271788e6163787fe",
"parent_got_revision": "f1e573402f388b25077009f05672e0c57375ed17",
"parent_got_revision_cp": "refs/heads/main@{#1219907}",
"parent_got_swiftshader_revision": "5c95af798ba41e5c8bb09891ee7398e7bfe2b1fb",
"parent_got_v8_revision": "e72e4c70f1216f9786f8f576f276144ab9579028",
"parent_got_v8_revision_cp": "refs/heads/12.1.44@{#1}",
"parent_got_webrtc_revision": "37df1c07b200458bae20fc474a907e4c6ef4e6a9",
"parent_got_webrtc_revision_cp": "refs/heads/main@{#41080}",
"swarm_hashes": {
"updater_tests": "a343e56f43c10ec451bbd3c1b68bee9f65571586427429253d22caf99dbce074/565",
"updater_tests_system": "d4385d4057c606c2d1b8d75f94cfa392775fecf22cfd33ff2cab06052e81ad18/565",
"updater_tests_win_uac": "9632dc7a99f83c25e74a6b442c98740fe2aefc0d5d51c4ad1a23bec9068e858c/565"
},
"swarming_command_lines_cwd": "out\\Debug_x64",
"swarming_command_lines_digest": "04644b3725667de8322112c049e098c517856de3e0dd50fcb242162058d8e657/93"
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f1e573402f388b25077009f05672e0c57375ed17",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8930782581055162832"
},
{
"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": "95174"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:44:11.167] Scheduled build:
{
"id": "8765352519146688161",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 70869,
"createdBy": "project:chromium",
"createTime": "2023-11-04T13:44:10.450910242Z",
"updateTime": "2023-11-04T13:44:10.450910242Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f1e573402f388b25077009f05672e0c57375ed17",
"ref": "refs/heads/main"
}
}
}
[13:44:11.167] Task URL: https://cr-buildbucket.appspot.com/build/8765352519146688161
[13:44:11.167] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:2:0) after 1m28s
[13:44:11.930] Received PubSub notification, asking Buildbucket for the build status
[13:44:11.953] Build status: SCHEDULED
[13:45:39.184] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:2:0)
[13:45:39.201] Build status: SCHEDULED
[13:45:39.201] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:4:0) after 2m26s
[13:48:05.223] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:4:0)
[13:48:05.251] Build status: SCHEDULED
[13:48:05.251] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:5:0) after 8m26s
[13:48:59.867] Received PubSub notification, asking Buildbucket for the build status
[13:48:59.907] Build status: STARTED
[13:56:31.273] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:5:0)
[13:56:31.339] Build status: STARTED
[13:56:31.339] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:7:0) after 2m6s
[13:58:37.452] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:7:0)
[13:58:37.473] Build status: STARTED
[13:58:37.473] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:8:0) after 1m41s
[14:00:18.531] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:8:0)
[14:00:18.557] Build status: STARTED
[14:00:18.557] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:9:0) after 9m15s
[14:09:33.742] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:9:0)
[14:09:33.770] Build status: STARTED
[14:09:33.770] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:10:0) after 2m53s
[14:12:27.084] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:10:0)
[14:12:27.102] Build status: STARTED
[14:12:27.102] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:11:0) after 1m35s
[14:14:02.120] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:11:0)
[14:14:02.144] Build status: STARTED
[14:14:02.145] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:12:0) after 6m34s
[14:20:36.226] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:12:0)
[14:20:36.282] Build status: STARTED
[14:20:36.282] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:13:0) after 1m4s
[14:21:40.340] Handling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:13:0)
[14:21:40.359] Build status: STARTED
[14:21:40.359] Scheduling timer "check-buildbucket-build-status" (chromium/win10-updater-tester-dbg:8930782581055162832:14:0) after 6m22s
[14:21:42.009] Received PubSub notification, asking Buildbucket for the build status
[14:21:42.038] Build:
{
"id": "8765352519146688161",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-updater-tester-dbg"
},
"number": 70869,
"createdBy": "project:chromium",
"createTime": "2023-11-04T13:44:10.450910242Z",
"startTime": "2023-11-04T13:48:50.601456Z",
"endTime": "2023-11-04T14:21:41.183156Z",
"updateTime": "2023-11-04T14:21:41.183156Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f1e573402f388b25077009f05672e0c57375ed17",
"ref": "refs/heads/main"
}
}
}
[14:21:42.038] Invocation finished in 37m32.790751349s with status SUCCEEDED