[22:07:01.135] New invocation is queued and will start shortly
[22:07:02.597] Starting the invocation (attempt 1)
[22:07:02.639] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:07:02.639] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:07:02.639] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022344476583561184",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"597e86a33319f47fb20799257e8376c4a6692b54\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022344476583561184",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/597e86a33319f47fb20799257e8376c4a6692b54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/597e86a33319f47fb20799257e8376c4a6692b54",
"gitiles_ref:refs/heads/master"
]
}
[22:07:03.342] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611785222715794",
"id": "8856914414264724176",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"597e86a33319f47fb20799257e8376c4a6692b54\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611785223081929",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180043",
"builder:Linux Builder (dbg)",
"buildset:commit/git/597e86a33319f47fb20799257e8376c4a6692b54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/597e86a33319f47fb20799257e8376c4a6692b54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022344476583561184",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856914414264724176/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1611785223082083",
"url": "https://ci.chromium.org/b/8856914414264724176",
"utcnow_ts": "1611785223334452"
}
}
[22:07:03.342] Task URL: https://ci.chromium.org/b/8856914414264724176
[22:07:03.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:2:0) after 1m0s
[22:07:07.577] Received PubSub notification, asking Buildbucket for the build status
[22:07:08.137] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:03.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:2:0)
[22:08:03.320] Timer tick, asking Buildbucket for the build status
[22:08:03.581] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:03.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:4:0) after 1m0s
[22:09:03.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:4:0)
[22:09:03.599] Timer tick, asking Buildbucket for the build status
[22:09:03.648] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:03.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:5:0) after 1m0s
[22:10:03.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:5:0)
[22:10:03.677] Timer tick, asking Buildbucket for the build status
[22:10:03.802] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:03.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:6:0) after 1m0s
[22:11:03.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:6:0)
[22:11:03.839] Timer tick, asking Buildbucket for the build status
[22:11:03.963] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:03.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:7:0) after 1m0s
[22:12:04.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:7:0)
[22:12:04.028] Timer tick, asking Buildbucket for the build status
[22:12:04.114] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:04.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:8:0) after 1m0s
[22:13:04.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:8:0)
[22:13:04.141] Timer tick, asking Buildbucket for the build status
[22:13:04.235] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:04.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:9:0) after 1m0s
[22:14:04.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:9:0)
[22:14:04.231] Timer tick, asking Buildbucket for the build status
[22:14:04.322] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:04.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:10:0) after 1m0s
[22:15:04.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:10:0)
[22:15:04.441] Timer tick, asking Buildbucket for the build status
[22:15:04.645] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:04.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:11:0) after 1m0s
[22:16:04.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:11:0)
[22:16:04.740] Timer tick, asking Buildbucket for the build status
[22:16:07.720] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:07.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:12:0) after 1m0s
[22:17:07.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:12:0)
[22:17:07.779] Timer tick, asking Buildbucket for the build status
[22:17:07.913] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:07.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:13:0) after 1m0s
[22:18:07.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:13:0)
[22:18:07.974] Timer tick, asking Buildbucket for the build status
[22:18:08.056] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:08.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:14:0) after 1m0s
[22:19:08.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:14:0)
[22:19:08.040] Timer tick, asking Buildbucket for the build status
[22:19:08.149] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:08.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:15:0) after 1m0s
[22:20:08.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:15:0)
[22:20:08.173] Timer tick, asking Buildbucket for the build status
[22:20:08.462] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:08.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:16:0) after 1m0s
[22:21:08.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:16:0)
[22:21:08.507] Timer tick, asking Buildbucket for the build status
[22:21:08.796] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:08.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:17:0) after 1m0s
[22:22:08.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:17:0)
[22:22:08.801] Timer tick, asking Buildbucket for the build status
[22:22:09.119] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:09.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:18:0) after 1m0s
[22:23:09.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:18:0)
[22:23:09.110] Timer tick, asking Buildbucket for the build status
[22:23:09.675] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:09.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:19:0) after 1m0s
[22:24:09.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:19:0)
[22:24:09.709] Timer tick, asking Buildbucket for the build status
[22:24:10.009] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:10.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:20:0) after 1m0s
[22:25:10.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:20:0)
[22:25:10.082] Timer tick, asking Buildbucket for the build status
[22:25:10.840] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:10.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:21:0) after 1m0s
[22:26:10.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:21:0)
[22:26:10.880] Timer tick, asking Buildbucket for the build status
[22:26:10.978] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:10.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:22:0) after 1m0s
[22:27:10.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:22:0)
[22:27:10.970] Timer tick, asking Buildbucket for the build status
[22:27:11.750] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:11.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:23:0) after 1m0s
[22:28:11.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:23:0)
[22:28:11.742] Timer tick, asking Buildbucket for the build status
[22:28:11.832] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:11.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:24:0) after 1m0s
[22:29:11.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:24:0)
[22:29:11.852] Timer tick, asking Buildbucket for the build status
[22:29:12.135] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:12.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:25:0) after 1m0s
[22:30:12.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:25:0)
[22:30:12.215] Timer tick, asking Buildbucket for the build status
[22:30:12.552] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:12.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:26:0) after 1m0s
[22:31:12.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:26:0)
[22:31:12.551] Timer tick, asking Buildbucket for the build status
[22:31:13.018] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:13.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:27:0) after 1m0s
[22:32:13.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:27:0)
[22:32:13.023] Timer tick, asking Buildbucket for the build status
[22:32:13.188] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:13.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:28:0) after 1m0s
[22:33:13.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:28:0)
[22:33:13.239] Timer tick, asking Buildbucket for the build status
[22:33:13.332] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:13.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:29:0) after 1m0s
[22:34:13.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:29:0)
[22:34:13.312] Timer tick, asking Buildbucket for the build status
[22:34:13.384] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:13.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:30:0) after 1m0s
[22:35:13.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:30:0)
[22:35:13.951] Timer tick, asking Buildbucket for the build status
[22:35:14.055] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:14.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:31:0) after 1m0s
[22:36:14.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:31:0)
[22:36:14.097] Timer tick, asking Buildbucket for the build status
[22:36:14.442] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:14.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:32:0) after 1m0s
[22:37:14.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:32:0)
[22:37:14.509] Timer tick, asking Buildbucket for the build status
[22:37:14.831] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:14.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:33:0) after 1m0s
[22:38:14.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:33:0)
[22:38:14.869] Timer tick, asking Buildbucket for the build status
[22:38:15.336] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:15.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:34:0) after 1m0s
[22:39:15.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:34:0)
[22:39:15.417] Timer tick, asking Buildbucket for the build status
[22:39:15.518] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:15.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:35:0) after 1m0s
[22:40:15.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:35:0)
[22:40:15.596] Timer tick, asking Buildbucket for the build status
[22:40:15.682] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:15.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:36:0) after 1m0s
[22:41:15.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:36:0)
[22:41:15.830] Timer tick, asking Buildbucket for the build status
[22:41:15.936] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:15.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:37:0) after 1m0s
[22:42:15.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:37:0)
[22:42:15.977] Timer tick, asking Buildbucket for the build status
[22:42:16.211] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:16.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:38:0) after 1m0s
[22:43:16.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:38:0)
[22:43:16.318] Timer tick, asking Buildbucket for the build status
[22:43:16.508] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:16.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:39:0) after 1m0s
[22:44:16.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:39:0)
[22:44:16.555] Timer tick, asking Buildbucket for the build status
[22:44:16.657] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:16.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:40:0) after 1m0s
[22:45:16.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:40:0)
[22:45:16.760] Timer tick, asking Buildbucket for the build status
[22:45:16.898] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:16.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:41:0) after 1m0s
[22:46:16.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:41:0)
[22:46:16.960] Timer tick, asking Buildbucket for the build status
[22:46:17.038] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:17.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:42:0) after 1m0s
[22:47:17.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:42:0)
[22:47:17.142] Timer tick, asking Buildbucket for the build status
[22:47:17.396] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:17.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:43:0) after 1m0s
[22:48:17.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:43:0)
[22:48:17.400] Timer tick, asking Buildbucket for the build status
[22:48:17.512] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:17.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:44:0) after 1m0s
[22:49:17.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:44:0)
[22:49:17.667] Timer tick, asking Buildbucket for the build status
[22:49:18.736] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:18.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:45:0) after 1m0s
[22:50:18.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:45:0)
[22:50:18.805] Timer tick, asking Buildbucket for the build status
[22:50:18.928] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:18.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:46:0) after 1m0s
[22:51:19.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:46:0)
[22:51:19.058] Timer tick, asking Buildbucket for the build status
[22:51:19.260] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:19.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:47:0) after 1m0s
[22:52:19.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:47:0)
[22:52:19.322] Timer tick, asking Buildbucket for the build status
[22:52:19.963] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:19.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:48:0) after 1m0s
[22:53:19.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:48:0)
[22:53:19.990] Timer tick, asking Buildbucket for the build status
[22:53:20.220] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:20.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:49:0) after 1m0s
[22:54:20.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:49:0)
[22:54:20.238] Timer tick, asking Buildbucket for the build status
[22:54:20.412] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:20.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:50:0) after 1m0s
[22:55:20.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:50:0)
[22:55:20.493] Timer tick, asking Buildbucket for the build status
[22:55:21.182] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:21.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:51:0) after 1m0s
[22:56:21.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:51:0)
[22:56:21.244] Timer tick, asking Buildbucket for the build status
[22:56:21.313] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:21.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:52:0) after 1m0s
[22:57:21.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:52:0)
[22:57:21.319] Timer tick, asking Buildbucket for the build status
[22:57:21.476] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:21.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:53:0) after 1m0s
[22:58:21.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:53:0)
[22:58:21.477] Timer tick, asking Buildbucket for the build status
[22:58:21.549] Build 8856914414264724176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:21.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022344476583561184:54:0) after 1m0s
[22:58:34.142] Received PubSub notification, asking Buildbucket for the build status
[22:58:34.917] Build 8856914414264724176: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:58:34.917] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611788312696080",
"created_by": "project:chromium",
"created_ts": "1611785222715794",
"id": "8856914414264724176",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"597e86a33319f47fb20799257e8376c4a6692b54\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"597e86a33319f47fb20799257e8376c4a6692b54\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-70-ukhp\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180043, \"got_angle_revision\": \"52afb6f17cbd13a290c2798b565067f47d47af86\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"597e86a33319f47fb20799257e8376c4a6692b54\", \"got_revision_cp\": \"refs/heads/master@{#847813}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"86f939547fc17da2ab1ed5a4b058bddb162dac9b\", \"got_v8_revision_cp\": \"refs/heads/9.0.87@{#1}\", \"got_webrtc_revision\": \"49dbad021e802197b3c0b966c03b4aa766a5b578\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33080}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"prev_got_revision\": \"f4be2777ccdded59c70655e10daabba6ac9422e8\", \"prev_got_revision_cp\": \"refs/heads/master@{#847788}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"597e86a33319f47fb20799257e8376c4a6692b54\", \"swarm_hashes_refs/heads/master(at){#847813}_without_patch\": {\"absl_hardening_tests\": \"11ee7a960e19ae03292eaedf40d4319f82060a3d\", \"accessibility_unittests\": \"c5d80a4a3798a24575d8a59fbc272e9e99552733\", \"angle_unittests\": \"92b0ba78a3f1b462e64ef4c09405b390b6e2d1f1\", \"app_shell_unittests\": \"83134779981cf4efaf8b4b7b4a5ce4a4c01391ee\", \"aura_unittests\": \"fa9aae30024db8833924ea03742bc998b3cedc8e\", \"base_unittests\": \"69fa52eca100e37e47833179cf8a32f964783b18\", \"base_util_unittests\": \"6393b3b95f26a7846c38c19ce4caa23acf2a62aa\", \"blink_common_unittests\": \"82928f8179e3105016dac1068744b29ceb4ad906\", \"blink_fuzzer_unittests\": \"42fbda8fe0f3e3f01d198ca200754a1c396deda9\", \"blink_heap_unittests\": \"f66175488951cf1d8cc89807445d4a2152bee024\", \"blink_platform_unittests\": \"2eea3d09ef25264b8b708aecf01b207763761294\", \"blink_python_tests\": \"9a67db75ef7b341a4dc68f3356d5ccc334fa96df\", \"blink_unittests\": \"e677c5a9f7b35e1c92b18adb7d38facb127bb37b\", \"blink_web_tests\": \"c404f43a981d30b2d7ec47bcee5188b5ba2d1aa7\", \"boringssl_crypto_tests\": \"13032c0cb7d175e93dfa0f22190a13aff31adf23\", \"boringssl_ssl_tests\": \"fcfb54d4e4c749fef5ed2b9698c4f91b7ab53e13\", \"browser_tests\": \"0bafdb9c703c4fe21598a70d5f7daf85077ba15e\", \"capture_unittests\": \"4b0b030f2b89dee87b6435f7e1dc0f04ea661f0b\", \"cast_unittests\": \"b4ec35ae89ebcb56cab1a39ce6a9ae322f1adec0\", \"cc_unittests\": \"b0d28b26927b64194aa79e75bebf86e9178b0408\", \"chrome_app_unittests\": \"bf9d195df96bd3cc87ff4d118aa12707f1b5484c\", \"chromedriver_unittests\": \"aebe460d669de6873f2c45b3b9b3f6aa9bf7d3fd\", \"components_browsertests\": \"fd405afcef1285fa695fe894794e10b0eedfe25d\", \"components_unittests\": \"b9ba30f6cde3b97895e6b436d01ddc7242e16fa4\", \"compositor_unittests\": \"26c5e730caf79d6d1efdd26fdfbeab9e8bb440e2\", \"content_browsertests\": \"8a4b0d9a34e8062e2d126b62f5beffaeb477036c\", \"content_shell_crash_test\": \"44e303b0a49d4f2867e2570a6bd3cb3dc4f4a29a\", \"content_unittests\": \"6dfe5655e7ba1bb1a23257e44364de2ce2fc09d6\", \"crashpad_tests\": \"183e278c79faf5a439a1adc8a9c79ea8d4f102a2\", \"cronet_tests\": \"1b258f14d4c8b93861ccb7d82d79bc08ac9c2135\", \"cronet_unittests\": \"8638c41ad28f8ccab76c97efdafcc85c5ceebbfd\", \"crypto_unittests\": \"547593f5d0bbaf62abda7ac4bf2de3b6000270a9\", \"dbus_unittests\": \"ddf859b697c4fd518520216a41f94c87947ee41f\", \"device_unittests\": \"33c719af97f42274069bcca300fa7d04450f1c5e\", \"display_unittests\": \"d3d14b107243da704265641bd55a8851fc8eb52d\", \"events_unittests\": \"4d042fc2feb0f890649ee8b57d5d1a5148ca2243\", \"extensions_browsertests\": \"24e4972ddebf9024c7bc0bf3afbc681141343ed3\", \"extensions_unittests\": \"4c34fb6e181bf45bb8496990e650b4178991b258\", \"filesystem_service_unittests\": \"efd0effa687a0d40226be5f4a3ed39a09a0ca3a6\", \"flatbuffers_unittests\": \"bc94b5892d7faa8d4260fa7d28e336b3c313737d\", \"gcm_unit_tests\": \"35c883cd50174046005aacbd14fe19ebaad885a1\", \"gfx_unittests\": \"23adacd5b3a2a52becbdeace7c04dd3bd0ce18d7\", \"gin_unittests\": \"b2ca3900873389eb48086d0b9e5e50cbe6c5afcc\", \"google_apis_unittests\": \"d0dbaa61fa03e8072e06e2702ebe8f4930052859\", \"gpu_unittests\": \"4514981929a29c681230b3e34d93506097ee6a27\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"6e058f61c93fcea97c211a6314421988bfadf72b\", \"headless_browsertests\": \"a150146761b44059b62a74cb1646002a4a2c7e0e\", \"headless_unittests\": \"db17e4537a33b51df40de1eddd731d0947800a08\", \"interactive_ui_tests\": \"ef4fbdb6471017479a11a3676e7318d21c25954b\", \"ipc_tests\": \"4c12f46e7507b2732e5e73fbe2ebde8601c657c5\", \"jingle_unittests\": \"0998ec6b0131f6a3cce6f22e9b42425d7f910f8c\", \"latency_unittests\": \"1ab80a406f8bdeae8cc2f9e2a327b9ec2fcbbc49\", \"libjingle_xmpp_unittests\": \"0c2cc06ad5e04da00846c5a87b94edb098c28525\", \"liburlpattern_unittests\": \"955882de25ca443147b5f3b29ca4ddd7ef6f2b98\", \"media_blink_unittests\": \"98d8dcbc0923e2698e09e6c943a5d6527c8c0ca7\", \"media_unittests\": \"67eff429ebbdfeaf0c43f66bf65283c76c94c258\", \"message_center_unittests\": \"eb5988275f3f944b24a86cc45895043be7f3eb16\", \"metrics_python_tests\": \"fdd2b28ad21f5b652dfe927f47f75849c63b7336\", \"midi_unittests\": \"008486d12e01b055ba5b568a88c79fd99274b572\", \"mojo_core_unittests\": \"538f4b1488bc9bf3856f343161b44f8c2add2e02\", \"mojo_unittests\": \"ca7c3d357671095cf61dbcee92cbf7c4ea16df53\", \"nacl_helper_nonsfi_unittests\": \"b9adf5f2afbf1172f1300eb99b605141fa407566\", \"nacl_loader_unittests\": \"996d0697da772a89f9ac947c8dd3b655e6329a34\", \"native_theme_unittests\": \"2c88c35f16a8bcdde7e254bc000a14802ab1f06b\", \"net_unittests\": \"327feeeba7a0a3c8f9ce149e1e1a0b86e9283c7c\", \"openscreen_unittests\": \"2f196ff0f552aec0da957d88679bdc58e3a3c2e7\", \"pdf_unittests\": \"b9034e813b3450c860b36373a2b1b86d3f30e9ad\", \"perfetto_unittests\": \"f60a13b5c6d63319cf7259f418a97e59276d8c12\", \"ppapi_unittests\": \"68e1eaaeedc638ee210621b15ccd47fbec464be5\", \"printing_unittests\": \"6985a5b3906733f92b237f1d6c9a88a98eb3bb86\", \"remoting_unittests\": \"539b3d43d495553f63c4ce55f86c5338aa2e58e8\", \"sandbox_linux_unittests\": \"f53f085afcda3a4abe6f38e212a0acd40ac84e20\", \"service_manager_unittests\": \"f354eaa0656463e64ba6d55290fb9150b6c1ffe3\", \"services_unittests\": \"9a0a4695bbd7e70d9e198d9e4cefa37b92c93745\", \"shell_dialogs_unittests\": \"40755af199d001a49960fcdda6e76e32631584c6\", \"skia_unittests\": \"061dcb9d7925e9a0d82e9d262643341b00595767\", \"snapshot_unittests\": \"bc4b97b79b9163d9e19abcd0e0f32e37badb8a9a\", \"sql_unittests\": \"1cd71202607f0e5386a9a2fd00ebc0a6d62d9fba\", \"storage_unittests\": \"d4926d8a30206a2103e6d60def98781d23e31b2d\", \"sync_integration_tests\": \"58c4e63cc8067e1294f2d2ee81f4b15d5d6c2783\", \"telemetry_gpu_unittests\": \"c440e0a7eb6b881f624f93fb3c2cb01e434fd8c9\", \"telemetry_perf_unittests\": \"c80ba1e13fe9f2bb446b675e7cedd9c4fbd64b6d\", \"telemetry_unittests\": \"f43aa71175523eec670e81c7c11fc6083d97ec7e\", \"traffic_annotation_auditor_unittests\": \"023178272c1b5cd4d7f120b2cb093ce8eaefcc37\", \"ui_base_unittests\": \"571b33e39b7a1c3e0e8bfc8433ea7cd2dbebf80e\", \"ui_touch_selection_unittests\": \"4f7511f3e5cab8a125326b6161cb46560ae40313\", \"unit_tests\": \"1a8a90ed2c73429af0ee080048ecd4ea26b809cf\", \"url_unittests\": \"8fb9b79359e6f88116dfad4dcd39975196d9f6f7\", \"views_perftests\": \"ccd0898be4868d64baa901697ee2965d62a47107\", \"views_unittests\": \"11462a7fe821f295a5153d07671d5f41e06c9adf\", \"viz_unittests\": \"63fa6e337d6109b7e5a9800fdc6ac61d51be8f03\", \"vr_common_unittests\": \"0f92dc62250442446abac43e8b82462830b3ccba\", \"vr_pixeltests\": \"2a6e19120eb7867b14c445fc2bfb8f0279d1031d\", \"webdriver_wpt_tests\": \"b25e1d7117e4f89ad17cabb4047488cf037d5f90\", \"weblayer_browsertests\": \"fb3382473489f9bb121db61c2fd7d072ce4933ae\", \"weblayer_unittests\": \"772d9741d8bf87345743410cf0f417e1f64ca8f8\", \"wm_unittests\": \"9a4d70a4d9a41036d9efd2eff00d7d96f0043901\", \"wtf_unittests\": \"d3f9dafc1f44543c3fc0ba5b5203fd44c0748544\", \"x11_unittests\": \"39081bfae9d2ae867944ab0365af4de415b2138d\", \"xr_browser_tests\": \"d1f25c214187f51ee55aef6674fd9eacb2256367\", \"zlib_unittests\": \"6fdbc4855eb1bdfc5233f82d3aec51668386ac26\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0cd6cf41ec42413cc9e5bdc0dde565dc7bee061bff1a52db1e25d07760950df7_v2\", \"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_53a0dbabd2cebac1b8e64bcbfab336eb0021d1dc40b2d4ba5321eb0a070d508c_v2\", \"builder_683151a13e11b6ef159b21e9ff1210b7a016189cdbfd66586ebc7bd6db856ba2_v2\", \"builder_79ddf9721ca7b7ce79374811fb2c516b44ee31d85deee669f4d7a1736cefaf3b_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_e952ecb177c3aa407c442a905d84d05be4034274537a5522f4d6fcc7004f535c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-70-ukhp\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611785225504342",
"status": "COMPLETED",
"status_changed_ts": "1611788313003745",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180043",
"builder:Linux Builder (dbg)",
"buildset:commit/git/597e86a33319f47fb20799257e8376c4a6692b54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/597e86a33319f47fb20799257e8376c4a6692b54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022344476583561184",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856914414264724176/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:515eb448d0848310",
"user_agent:luci-scheduler"
],
"updated_ts": "1611788313008638",
"url": "https://ci.chromium.org/b/8856914414264724176",
"utcnow_ts": "1611788314905060"
}
}
[22:58:34.917] Invocation finished in 51m33.797666374s with status SUCCEEDED