[20:32:06.155] New invocation is queued and will start shortly
[20:32:07.302] Starting the invocation (attempt 1)
[20:32:07.350] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:32:07.350] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:32:07.350] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053878192518835392",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3d706992a28aa94b5a70c895bf1b45520d6326cb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053878192518835392",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3d706992a28aa94b5a70c895bf1b45520d6326cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d706992a28aa94b5a70c895bf1b45520d6326cb",
"gitiles_ref:refs/heads/master"
]
}
[20:32:08.590] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581712327481507",
"id": "8888448130457025008",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3d706992a28aa94b5a70c895bf1b45520d6326cb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581712328317534",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168608",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3d706992a28aa94b5a70c895bf1b45520d6326cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d706992a28aa94b5a70c895bf1b45520d6326cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053878192518835392",
"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/8888448130457025008/+/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": "1581712328317684",
"url": "https://ci.chromium.org/b/8888448130457025008",
"utcnow_ts": "1581712328579798"
}
}
[20:32:08.591] Task URL: https://ci.chromium.org/b/8888448130457025008
[20:32:08.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:2:0) after 1m0s
[20:33:08.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:2:0)
[20:33:08.638] Timer tick, asking Buildbucket for the build status
[20:33:08.762] Build 8888448130457025008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:08.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:3:0) after 1m0s
[20:34:08.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:3:0)
[20:34:08.860] Timer tick, asking Buildbucket for the build status
[20:34:08.953] Build 8888448130457025008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:08.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:4:0) after 1m0s
[20:35:09.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:4:0)
[20:35:09.057] Timer tick, asking Buildbucket for the build status
[20:35:09.259] Build 8888448130457025008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:09.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:5:0) after 1m0s
[20:36:09.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:5:0)
[20:36:09.283] Timer tick, asking Buildbucket for the build status
[20:36:09.389] Build 8888448130457025008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:09.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:6:0) after 1m0s
[20:37:09.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:6:0)
[20:37:09.457] Timer tick, asking Buildbucket for the build status
[20:37:09.783] Build 8888448130457025008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:09.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:7:0) after 1m0s
[20:37:11.871] Received PubSub notification, asking Buildbucket for the build status
[20:37:11.937] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:09.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:7:0)
[20:38:09.863] Timer tick, asking Buildbucket for the build status
[20:38:09.970] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:09.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:9:0) after 1m0s
[20:39:10.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:9:0)
[20:39:10.125] Timer tick, asking Buildbucket for the build status
[20:39:10.226] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:10.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:10:0) after 1m0s
[20:40:10.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:10:0)
[20:40:10.288] Timer tick, asking Buildbucket for the build status
[20:40:10.429] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:10.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:11:0) after 1m0s
[20:41:10.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:11:0)
[20:41:10.501] Timer tick, asking Buildbucket for the build status
[20:41:10.577] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:10.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:12:0) after 1m0s
[20:42:10.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:12:0)
[20:42:10.732] Timer tick, asking Buildbucket for the build status
[20:42:10.825] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:10.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:13:0) after 1m0s
[20:43:10.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:13:0)
[20:43:10.928] Timer tick, asking Buildbucket for the build status
[20:43:11.411] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:11.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:14:0) after 1m0s
[20:44:11.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:14:0)
[20:44:11.487] Timer tick, asking Buildbucket for the build status
[20:44:11.634] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:11.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:15:0) after 1m0s
[20:45:11.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:15:0)
[20:45:11.682] Timer tick, asking Buildbucket for the build status
[20:45:11.806] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:11.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:16:0) after 1m0s
[20:46:11.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:16:0)
[20:46:11.958] Timer tick, asking Buildbucket for the build status
[20:46:12.053] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:12.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:17:0) after 1m0s
[20:47:12.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:17:0)
[20:47:12.137] Timer tick, asking Buildbucket for the build status
[20:47:12.253] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:12.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:18:0) after 1m0s
[20:48:12.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:18:0)
[20:48:12.339] Timer tick, asking Buildbucket for the build status
[20:48:12.588] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:12.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:19:0) after 1m0s
[20:49:12.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:19:0)
[20:49:12.704] Timer tick, asking Buildbucket for the build status
[20:49:12.806] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:12.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:20:0) after 1m0s
[20:50:13.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:20:0)
[20:50:13.053] Timer tick, asking Buildbucket for the build status
[20:50:13.205] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:13.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:21:0) after 1m0s
[20:51:13.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:21:0)
[20:51:13.251] Timer tick, asking Buildbucket for the build status
[20:51:13.338] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:13.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:22:0) after 1m0s
[20:52:13.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:22:0)
[20:52:13.451] Timer tick, asking Buildbucket for the build status
[20:52:13.560] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:13.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:23:0) after 1m0s
[20:53:13.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:23:0)
[20:53:13.604] Timer tick, asking Buildbucket for the build status
[20:53:13.752] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:13.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:24:0) after 1m0s
[20:54:13.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:24:0)
[20:54:13.882] Timer tick, asking Buildbucket for the build status
[20:54:14.193] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:14.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:25:0) after 1m0s
[20:55:14.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:25:0)
[20:55:14.218] Timer tick, asking Buildbucket for the build status
[20:55:14.517] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:26:0) after 1m0s
[20:56:14.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:26:0)
[20:56:14.534] Timer tick, asking Buildbucket for the build status
[20:56:14.644] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:14.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:27:0) after 1m0s
[20:57:14.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:27:0)
[20:57:14.743] Timer tick, asking Buildbucket for the build status
[20:57:14.991] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:14.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:28:0) after 1m0s
[20:58:14.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:28:0)
[20:58:14.976] Timer tick, asking Buildbucket for the build status
[20:58:15.255] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:15.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:29:0) after 1m0s
[20:59:15.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:29:0)
[20:59:15.399] Timer tick, asking Buildbucket for the build status
[20:59:15.731] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:15.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:30:0) after 1m0s
[21:00:15.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:30:0)
[21:00:15.869] Timer tick, asking Buildbucket for the build status
[21:00:15.979] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:15.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:31:0) after 1m0s
[21:01:16.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:31:0)
[21:01:16.092] Timer tick, asking Buildbucket for the build status
[21:01:16.204] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:16.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:32:0) after 1m0s
[21:02:16.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:32:0)
[21:02:16.260] Timer tick, asking Buildbucket for the build status
[21:02:16.457] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:16.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:33:0) after 1m0s
[21:03:16.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:33:0)
[21:03:16.498] Timer tick, asking Buildbucket for the build status
[21:03:16.790] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:16.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:34:0) after 1m0s
[21:04:16.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:34:0)
[21:04:16.889] Timer tick, asking Buildbucket for the build status
[21:04:17.005] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:17.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:35:0) after 1m0s
[21:05:17.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:35:0)
[21:05:17.037] Timer tick, asking Buildbucket for the build status
[21:05:17.135] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:17.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:36:0) after 1m0s
[21:06:17.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:36:0)
[21:06:17.192] Timer tick, asking Buildbucket for the build status
[21:06:17.309] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:17.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:37:0) after 1m0s
[21:07:17.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:37:0)
[21:07:17.442] Timer tick, asking Buildbucket for the build status
[21:07:17.527] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:17.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:38:0) after 1m0s
[21:08:17.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:38:0)
[21:08:17.528] Timer tick, asking Buildbucket for the build status
[21:08:17.779] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:17.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:39:0) after 1m0s
[21:09:17.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:39:0)
[21:09:17.933] Timer tick, asking Buildbucket for the build status
[21:09:18.128] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:18.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:40:0) after 1m0s
[21:10:18.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:40:0)
[21:10:18.189] Timer tick, asking Buildbucket for the build status
[21:10:18.300] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:18.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:41:0) after 1m0s
[21:11:18.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:41:0)
[21:11:18.542] Timer tick, asking Buildbucket for the build status
[21:11:18.642] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:18.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:42:0) after 1m0s
[21:12:18.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:42:0)
[21:12:18.702] Timer tick, asking Buildbucket for the build status
[21:12:18.785] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:18.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:43:0) after 1m0s
[21:13:18.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:43:0)
[21:13:18.918] Timer tick, asking Buildbucket for the build status
[21:13:19.015] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:19.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:44:0) after 1m0s
[21:14:19.060] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:44:0)
[21:14:19.060] Timer tick, asking Buildbucket for the build status
[21:14:19.459] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:19.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:45:0) after 1m0s
[21:15:19.531] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:45:0)
[21:15:19.531] Timer tick, asking Buildbucket for the build status
[21:15:19.653] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:19.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:46:0) after 1m0s
[21:16:19.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:46:0)
[21:16:19.723] Timer tick, asking Buildbucket for the build status
[21:16:20.001] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:20.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:47:0) after 1m0s
[21:17:20.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:47:0)
[21:17:20.049] Timer tick, asking Buildbucket for the build status
[21:17:20.331] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:20.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:48:0) after 1m0s
[21:18:20.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:48:0)
[21:18:20.435] Timer tick, asking Buildbucket for the build status
[21:18:20.710] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:20.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:49:0) after 1m0s
[21:19:20.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:49:0)
[21:19:20.962] Timer tick, asking Buildbucket for the build status
[21:19:21.073] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:21.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:50:0) after 1m0s
[21:20:21.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:50:0)
[21:20:21.239] Timer tick, asking Buildbucket for the build status
[21:20:21.341] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:21.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:51:0) after 1m0s
[21:21:21.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:51:0)
[21:21:21.374] Timer tick, asking Buildbucket for the build status
[21:21:21.625] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:21.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:52:0) after 1m0s
[21:22:21.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:52:0)
[21:22:21.748] Timer tick, asking Buildbucket for the build status
[21:22:22.073] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:22.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:53:0) after 1m0s
[21:23:22.111] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:53:0)
[21:23:22.111] Timer tick, asking Buildbucket for the build status
[21:23:22.217] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:22.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:54:0) after 1m0s
[21:24:22.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:54:0)
[21:24:22.292] Timer tick, asking Buildbucket for the build status
[21:24:22.392] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:22.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:55:0) after 1m0s
[21:25:22.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:55:0)
[21:25:22.498] Timer tick, asking Buildbucket for the build status
[21:25:22.610] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:22.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:56:0) after 1m0s
[21:26:22.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:56:0)
[21:26:22.683] Timer tick, asking Buildbucket for the build status
[21:26:23.092] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:23.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:57:0) after 1m0s
[21:27:23.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:57:0)
[21:27:23.097] Timer tick, asking Buildbucket for the build status
[21:27:23.212] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:23.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:58:0) after 1m0s
[21:28:23.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:58:0)
[21:28:23.397] Timer tick, asking Buildbucket for the build status
[21:28:23.758] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:23.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:59:0) after 1m0s
[21:29:23.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:59:0)
[21:29:23.823] Timer tick, asking Buildbucket for the build status
[21:29:23.985] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:23.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:60:0) after 1m0s
[21:30:24.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:60:0)
[21:30:24.121] Timer tick, asking Buildbucket for the build status
[21:30:24.318] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:24.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:61:0) after 1m0s
[21:31:24.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:61:0)
[21:31:24.426] Timer tick, asking Buildbucket for the build status
[21:31:24.553] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:24.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:62:0) after 1m0s
[21:32:24.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:62:0)
[21:32:24.665] Timer tick, asking Buildbucket for the build status
[21:32:24.762] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:24.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:63:0) after 1m0s
[21:33:24.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:63:0)
[21:33:24.799] Timer tick, asking Buildbucket for the build status
[21:33:24.998] Build 8888448130457025008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:24.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053878192518835392:64:0) after 1m0s
[21:34:24.171] Received PubSub notification, asking Buildbucket for the build status
[21:34:24.227] Build 8888448130457025008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:34:24.227] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581716043997459",
"created_by": "project:chromium",
"created_ts": "1581712327481507",
"id": "8888448130457025008",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3d706992a28aa94b5a70c895bf1b45520d6326cb\"}}",
"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\"}, \"$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-19-semu\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168608, \"got_angle_revision\": \"9f4ab98d1264450563d023c2f476504cc0556e73\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3d706992a28aa94b5a70c895bf1b45520d6326cb\", \"got_revision_cp\": \"refs/heads/master@{#741560}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"f9f999f5a2eb6dd586a1da03e6b400d044ae6022\", \"got_v8_revision\": \"c55cadc74ef11de773c5d8b109978238f5d2a76e\", \"got_v8_revision_cp\": \"refs/heads/8.2.78@{#1}\", \"got_webrtc_revision\": \"08b11cafae02834dedb3230321c5f2c775febca2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30526}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3d706992a28aa94b5a70c895bf1b45520d6326cb\", \"swarm_hashes_refs/heads/master(at){#741560}_without_patch\": {\"accessibility_unittests\": \"f32304c8039df82837d11f0b0ba42bf971803397\", \"angle_unittests\": \"9212a2ebe5c7b18f888a0c5d0e27fa1d57b1923c\", \"app_shell_unittests\": \"2fd050774f71ca7e310bd3f5ba1f77127fcf76cf\", \"aura_unittests\": \"839114225759da87dd0a9d05bab7ecd3d50056d8\", \"base_unittests\": \"a5deff8bc84c1546ffa1df150b2828a7d4cfe342\", \"base_util_unittests\": \"247f2b6d2d1a520255b8a462ea858437da74837c\", \"blink_common_unittests\": \"1c79fad4a9e4df20c81f673e05ae5cf9cd123bf7\", \"blink_fuzzer_unittests\": \"62d11a643b9daedd043fdcac2b0f4e46facc05db\", \"blink_heap_unittests\": \"5804ca8e1db1df7706e57dc2da5de749394cb1fa\", \"blink_platform_unittests\": \"2dde26baf6fcb7903a149d2c811ff4cee0e6645f\", \"blink_python_tests\": \"1b95493452a359d4dd9f9de7c6b9b919fd3a9be4\", \"blink_unittests\": \"f1fcfb7731fdb1c2b04844bf629c0c1957cccb5c\", \"blink_web_tests\": \"f0e7ebe6f9bcd616e1e47b587447940a6142d7a0\", \"boringssl_crypto_tests\": \"9927cc1e99d1487b4ad37293c25e076ff7dfb475\", \"boringssl_ssl_tests\": \"ca8450965b384932401dd32fb1a196c1b8f2b90a\", \"browser_tests\": \"3537033dd3712258a8bc0519330fdee7c1f886e0\", \"cacheinvalidation_unittests\": \"615294346db7f37481d645ada108521ba69a3225\", \"capture_unittests\": \"55bc9ec2b209f8d6596617b361c066ced2feb667\", \"cast_unittests\": \"483465d7acacb0de2a7697ae537110d5711f51f1\", \"cc_unittests\": \"d22465a89f1b23f3c2acfe06f4c0fd7f6cdde7a7\", \"chrome_app_unittests\": \"ada1f31fafd66b9b8a7e4bed44578c6a8e15049f\", \"chromedriver_unittests\": \"56198fa8656cc70296a405db47d52c9d56317865\", \"components_browsertests\": \"c8c1d1a41c9de313997b7bd73835336dff6ff955\", \"components_unittests\": \"020238e0b98e8a675f6a07654d172110eaa9327a\", \"compositor_unittests\": \"5c8d03c38dff787d85f946da4a2306bd004d11e1\", \"content_browsertests\": \"14193a693eb36fd3e49dc7307635fd7bda5dfb90\", \"content_shell_crash_test\": \"3f64b0059a146bdd49dd6b9851bae85701cd9daf\", \"content_unittests\": \"873975189e379267b4998a772b8c970768d517ad\", \"crashpad_tests\": \"74b7448adf864686aa5ad81e0e2497db9295d792\", \"cronet_tests\": \"cca3353a9a81b5998b7f8066655edfcf0ecd6ebf\", \"cronet_unittests\": \"faec122b307e4b7e4f0652949d63b35a54052e84\", \"crypto_unittests\": \"df8d2afb2c55ec3ac22f88365f9e38b2b1578b07\", \"dbus_unittests\": \"3bcdbd2351dd00b87692f6e6150f8bcb2cdbef74\", \"device_unittests\": \"ba05b1bf75d821732ffd944e02062417c5b2c779\", \"display_unittests\": \"101aa0c68616cc03cbea25eabfbc9b34afabe5f7\", \"events_unittests\": \"1fe7cc8044d16779da4b039628049ebf77efed53\", \"extensions_browsertests\": \"0faa9a732f504ea1baef0949ea2e0822ed4e9514\", \"extensions_unittests\": \"7a3b317672c7a947ab7836d5f80f1841f32a10ff\", \"filesystem_service_unittests\": \"5c60b0cb4f5846df1aebb6c7fd786afe697120ad\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"602196066e1b6b5401734ecda20d1639d50500dc\", \"gfx_unittests\": \"0903f800d118a61a6e0cbafb45d91f8da6899a5e\", \"gin_unittests\": \"dc381128d1a86307aab35e8a5f1ccd8f24f85855\", \"google_apis_unittests\": \"e6d1cdcff4dacd85c95845c2d7231094eaaceae6\", \"gpu_unittests\": \"74f86a4a856d95604a772a0def0872d083f0ccf9\", \"grit_python_unittests\": \"314a136826c68f2b20f2d52ddf6f5e567311beb1\", \"gwp_asan_unittests\": \"124524fe994b7cf83203041ef7d85f9b2523d970\", \"headless_browsertests\": \"6f26da0e931b2765a019fcac5a3bfce5406febe9\", \"headless_unittests\": \"1b8ce718cf683026034ea8094f934fae9c2867c2\", \"interactive_ui_tests\": \"18e764eaef27af21e1f2fd11511ce23c44b8c273\", \"ipc_tests\": \"20e73dda8e70d0a41757d82d04c0294a90dab113\", \"jingle_unittests\": \"91cc77876daa15e7cc74c5a8f73efc6a949c9363\", \"latency_unittests\": \"2265c2da0e041b88dd9cf30208fbff93a1ed6f71\", \"libjingle_xmpp_unittests\": \"a580d3ccd592675994a6a4396b6d0d01b5b6e132\", \"media_blink_unittests\": \"7de6afbe157fc298ada1fd740df8346ed1d419ac\", \"media_service_unittests\": \"53c7dd03687585afce694c822ae04d54b476dd6c\", \"media_unittests\": \"5c8bce1ae4204a0e1322f6df2b8f3758832f5e62\", \"message_center_unittests\": \"9fc3bb55f7c868f28334a3a280741f7239d5d1ef\", \"metrics_python_tests\": \"1587a00550ea08db469a45f87d7cba22e390286f\", \"midi_unittests\": \"27be6db5f7a123710058e24adf3aa3311b775817\", \"mojo_core_unittests\": \"5555951f1e9cc8037fb4c89c2acaba5eadcc3994\", \"mojo_unittests\": \"abd9d1f0ce21c26fbe86ff3b3159b454a437f2c9\", \"nacl_helper_nonsfi_unittests\": \"5bbf64a2ea3b405004061d5c42050e572cbe6696\", \"nacl_loader_unittests\": \"0538d9169c02ba88c74d54bd173ee6daeae14718\", \"native_theme_unittests\": \"55e5cf6d8eca8fedfb6ad9a13915defaaa081fad\", \"net_unittests\": \"ca111de0ba0f9a28d6eea5b1e004417c2991eb7c\", \"pdf_unittests\": \"02f98fa6fe5bc5490be6abd30c32c61c0d6389c8\", \"perfetto_unittests\": \"069e903a5e1d6ed411e10459e3acbad8c1614874\", \"ppapi_unittests\": \"68862dc80ce08d2af48c278f3986739ea9a149fc\", \"printing_unittests\": \"e117508ba02a987d871cf7e5fbdf104760e5ba2c\", \"remoting_unittests\": \"61ceb7ceb6fc4e0bc3fdf36ad800ee5874690c84\", \"sandbox_linux_unittests\": \"2f14b75e6fc90c0eaaff009c54bd8e45911915ad\", \"service_manager_unittests\": \"4b15fd98df29bb543462284aab82a1935ad7a61d\", \"services_unittests\": \"f6475c40c9ad8f0477ccb38c0bc9d447d503fb49\", \"shell_dialogs_unittests\": \"8d51d253b81820aff7c22e88370a18bc31e6d01f\", \"skia_unittests\": \"deff639d424a9466df215366672843086ad9753b\", \"snapshot_unittests\": \"a3b85d1f9ecd5274debfa763d3dc45f3216408b0\", \"sql_unittests\": \"004333257e2f8309f6b70416273ba520965cfe8e\", \"storage_unittests\": \"006d66b4082c344a4b18314c15665ed9e533bb9f\", \"sync_integration_tests\": \"90b6ad431a7fb8f6eb684174123cdd344d4a5818\", \"telemetry_gpu_unittests\": \"b01e57baf71a1a5f426fad4ba3e636601e677d1f\", \"telemetry_perf_unittests\": \"d7b7f31b7ba4bb973dfbe87c082b0c70b7e3b383\", \"telemetry_unittests\": \"e2fc81aec7906f1f4ed9983230997e0fa8573509\", \"traffic_annotation_auditor_unittests\": \"4a97d93f399f3637f41143ffd0e8401d7126e9e7\", \"ui_base_unittests\": \"892cdbcbc12ff0a95f121046c135c0cc19c63786\", \"ui_touch_selection_unittests\": \"b4cdbfdbaa47be1f076f80c8a7bba02472eb9e59\", \"unit_tests\": \"3d8947c33032ac6568c0dd8fa83b34756f4bbc36\", \"url_unittests\": \"2e50dd850e1fcb91165ac6b33408aa7d4f03edce\", \"views_perftests\": \"d99747e4a5ac0adbd1e327e08a1d19fd12d703b9\", \"views_unittests\": \"397649106e40d2e4bbd8eb60347f72746d5f9a6a\", \"viz_unittests\": \"145266579d2def5fcbe46c2f1b17d0492f619e72\", \"vr_common_unittests\": \"5877f96ae43eb9d920afe42ab38bcbcea0ae9f00\", \"vr_pixeltests\": \"e16b09aa9c7784b6f210371cd811220f8d61be75\", \"webdriver_wpt_tests\": \"5875862862a4a010517b903fd9d122c64423847b\", \"weblayer_browsertests\": \"5e2414743abd1431f43933a89ac7e8d4d71d6a95\", \"wm_unittests\": \"809d8e9bacf13bd8232f9999f61d68da954a9137\", \"wtf_unittests\": \"88d7bc3827636331ef1d12395e9691f4e6b78c2e\", \"xr_browser_tests\": \"eecf5c802ffe22b35db073664d2dc0e0722cd357\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b15148fa2a471165482335bd523b5eee69ace70a2c04528f88245080a969046_v2\", \"builder_349392596e0d17d3422c55529f4e230875f36ec061130c176581539a4c7cd365_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-19-semu\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581712623352872",
"status": "COMPLETED",
"status_changed_ts": "1581716063786250",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168608",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3d706992a28aa94b5a70c895bf1b45520d6326cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d706992a28aa94b5a70c895bf1b45520d6326cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053878192518835392",
"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/8888448130457025008/+/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:4a5e3851bcddab10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581716063802275",
"url": "https://ci.chromium.org/b/8888448130457025008",
"utcnow_ts": "1581716064218712"
}
}
[21:34:24.227] Invocation finished in 1h2m18.094312286s with status SUCCEEDED