[11:32:58.282] New invocation is queued and will start shortly
[11:32:59.715] Starting the invocation (attempt 1)
[11:32:59.763] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:32:59.763] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:32:59.763] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052190769367585296",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c54304438b48311c1c258d8ab2e66622d5ba9f19\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052190769367585296",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/c54304438b48311c1c258d8ab2e66622d5ba9f19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c54304438b48311c1c258d8ab2e66622d5ba9f19",
"gitiles_ref:refs/heads/master"
]
}
[11:33:00.794] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583321579943192",
"id": "8886760706947765824",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c54304438b48311c1c258d8ab2e66622d5ba9f19\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583321580395805",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169321",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c54304438b48311c1c258d8ab2e66622d5ba9f19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c54304438b48311c1c258d8ab2e66622d5ba9f19",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052190769367585296",
"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/8886760706947765824/+/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": "1583321580396093",
"url": "https://ci.chromium.org/b/8886760706947765824",
"utcnow_ts": "1583321580780728"
}
}
[11:33:00.794] Task URL: https://ci.chromium.org/b/8886760706947765824
[11:33:00.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:2:0) after 1m0s
[11:34:01.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:2:0)
[11:34:01.059] Timer tick, asking Buildbucket for the build status
[11:34:01.310] Build 8886760706947765824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:34:01.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:3:0) after 1m0s
[11:35:01.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:3:0)
[11:35:01.427] Timer tick, asking Buildbucket for the build status
[11:35:01.572] Build 8886760706947765824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:35:01.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:4:0) after 1m0s
[11:36:01.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:4:0)
[11:36:01.637] Timer tick, asking Buildbucket for the build status
[11:36:01.861] Build 8886760706947765824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:36:01.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:5:0) after 1m0s
[11:37:01.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:5:0)
[11:37:01.921] Timer tick, asking Buildbucket for the build status
[11:37:01.996] Build 8886760706947765824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:37:01.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:6:0) after 1m0s
[11:38:02.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:6:0)
[11:38:02.104] Timer tick, asking Buildbucket for the build status
[11:38:02.191] Build 8886760706947765824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:38:02.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:7:0) after 1m0s
[11:38:04.167] Received PubSub notification, asking Buildbucket for the build status
[11:38:04.322] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:02.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:7:0)
[11:39:02.257] Timer tick, asking Buildbucket for the build status
[11:39:02.436] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:02.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:9:0) after 1m0s
[11:40:02.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:9:0)
[11:40:02.460] Timer tick, asking Buildbucket for the build status
[11:40:02.603] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:02.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:10:0) after 1m0s
[11:41:02.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:10:0)
[11:41:02.700] Timer tick, asking Buildbucket for the build status
[11:41:02.806] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:02.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:11:0) after 1m0s
[11:42:02.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:11:0)
[11:42:02.798] Timer tick, asking Buildbucket for the build status
[11:42:02.969] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:02.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:12:0) after 1m0s
[11:43:02.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:12:0)
[11:43:02.990] Timer tick, asking Buildbucket for the build status
[11:43:03.338] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:03.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:13:0) after 1m0s
[11:44:03.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:13:0)
[11:44:03.366] Timer tick, asking Buildbucket for the build status
[11:44:03.679] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:03.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:14:0) after 1m0s
[11:45:03.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:14:0)
[11:45:03.714] Timer tick, asking Buildbucket for the build status
[11:45:03.836] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:03.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:15:0) after 1m0s
[11:46:03.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:15:0)
[11:46:03.901] Timer tick, asking Buildbucket for the build status
[11:46:04.233] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:04.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:16:0) after 1m0s
[11:47:04.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:16:0)
[11:47:04.278] Timer tick, asking Buildbucket for the build status
[11:47:04.406] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:04.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:17:0) after 1m0s
[11:48:04.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:17:0)
[11:48:04.497] Timer tick, asking Buildbucket for the build status
[11:48:04.649] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:04.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:18:0) after 1m0s
[11:49:04.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:18:0)
[11:49:04.675] Timer tick, asking Buildbucket for the build status
[11:49:06.149] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:06.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:19:0) after 1m0s
[11:50:06.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:19:0)
[11:50:06.288] Timer tick, asking Buildbucket for the build status
[11:50:06.469] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:06.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:20:0) after 1m0s
[11:51:06.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:20:0)
[11:51:06.568] Timer tick, asking Buildbucket for the build status
[11:51:06.797] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:06.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:21:0) after 1m0s
[11:52:06.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:21:0)
[11:52:06.774] Timer tick, asking Buildbucket for the build status
[11:52:06.898] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:06.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:22:0) after 1m0s
[11:53:06.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:22:0)
[11:53:06.994] Timer tick, asking Buildbucket for the build status
[11:53:07.131] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:07.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:23:0) after 1m0s
[11:54:07.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:23:0)
[11:54:07.158] Timer tick, asking Buildbucket for the build status
[11:54:07.282] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:07.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:24:0) after 1m0s
[11:55:07.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:24:0)
[11:55:07.327] Timer tick, asking Buildbucket for the build status
[11:55:07.460] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:07.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:25:0) after 1m0s
[11:56:07.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:25:0)
[11:56:07.591] Timer tick, asking Buildbucket for the build status
[11:56:07.725] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:07.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:26:0) after 1m0s
[11:57:08.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:26:0)
[11:57:08.003] Timer tick, asking Buildbucket for the build status
[11:57:08.360] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:08.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:27:0) after 1m0s
[11:58:08.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:27:0)
[11:58:08.739] Timer tick, asking Buildbucket for the build status
[11:58:08.899] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:08.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:28:0) after 1m0s
[11:59:09.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:28:0)
[11:59:09.003] Timer tick, asking Buildbucket for the build status
[11:59:09.145] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:09.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:29:0) after 1m0s
[12:00:09.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:29:0)
[12:00:09.343] Timer tick, asking Buildbucket for the build status
[12:00:09.463] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:09.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:30:0) after 1m0s
[12:01:09.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:30:0)
[12:01:09.530] Timer tick, asking Buildbucket for the build status
[12:01:09.766] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:09.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:31:0) after 1m0s
[12:02:10.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:31:0)
[12:02:10.076] Timer tick, asking Buildbucket for the build status
[12:02:10.329] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:10.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:32:0) after 1m0s
[12:03:10.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:32:0)
[12:03:10.455] Timer tick, asking Buildbucket for the build status
[12:03:10.568] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:10.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:33:0) after 1m0s
[12:04:10.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:33:0)
[12:04:10.671] Timer tick, asking Buildbucket for the build status
[12:04:10.804] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:10.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:34:0) after 1m0s
[12:05:10.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:34:0)
[12:05:10.876] Timer tick, asking Buildbucket for the build status
[12:05:10.990] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:10.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:35:0) after 1m0s
[12:06:11.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:35:0)
[12:06:11.029] Timer tick, asking Buildbucket for the build status
[12:06:11.204] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:11.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:36:0) after 1m0s
[12:07:11.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:36:0)
[12:07:11.234] Timer tick, asking Buildbucket for the build status
[12:07:11.326] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:11.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:37:0) after 1m0s
[12:08:11.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:37:0)
[12:08:11.348] Timer tick, asking Buildbucket for the build status
[12:08:11.516] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:11.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:38:0) after 1m0s
[12:09:11.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:38:0)
[12:09:11.591] Timer tick, asking Buildbucket for the build status
[12:09:11.703] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:11.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:39:0) after 1m0s
[12:10:11.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:39:0)
[12:10:11.849] Timer tick, asking Buildbucket for the build status
[12:10:11.985] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:11.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:40:0) after 1m0s
[12:11:12.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:40:0)
[12:11:12.066] Timer tick, asking Buildbucket for the build status
[12:11:12.192] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:12.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:41:0) after 1m0s
[12:12:12.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:41:0)
[12:12:12.291] Timer tick, asking Buildbucket for the build status
[12:12:12.440] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:12.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:42:0) after 1m0s
[12:13:12.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:42:0)
[12:13:12.502] Timer tick, asking Buildbucket for the build status
[12:13:12.676] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:12.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:43:0) after 1m0s
[12:14:12.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:43:0)
[12:14:12.700] Timer tick, asking Buildbucket for the build status
[12:14:12.859] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:12.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:44:0) after 1m0s
[12:15:12.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:44:0)
[12:15:12.916] Timer tick, asking Buildbucket for the build status
[12:15:13.061] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:13.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:45:0) after 1m0s
[12:16:13.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:45:0)
[12:16:13.083] Timer tick, asking Buildbucket for the build status
[12:16:13.262] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:13.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:46:0) after 1m0s
[12:17:13.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:46:0)
[12:17:13.344] Timer tick, asking Buildbucket for the build status
[12:17:13.657] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:13.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:47:0) after 1m0s
[12:18:13.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:47:0)
[12:18:13.765] Timer tick, asking Buildbucket for the build status
[12:18:13.990] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:13.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:48:0) after 1m0s
[12:19:14.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:48:0)
[12:19:14.164] Timer tick, asking Buildbucket for the build status
[12:19:14.287] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:14.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:49:0) after 1m0s
[12:20:14.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:49:0)
[12:20:14.307] Timer tick, asking Buildbucket for the build status
[12:20:14.447] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:14.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:50:0) after 1m0s
[12:21:14.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:50:0)
[12:21:14.469] Timer tick, asking Buildbucket for the build status
[12:21:14.598] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:14.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:51:0) after 1m0s
[12:22:14.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:51:0)
[12:22:14.649] Timer tick, asking Buildbucket for the build status
[12:22:14.732] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:14.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:52:0) after 1m0s
[12:23:14.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:52:0)
[12:23:14.755] Timer tick, asking Buildbucket for the build status
[12:23:14.988] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:14.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:53:0) after 1m0s
[12:24:15.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:53:0)
[12:24:15.134] Timer tick, asking Buildbucket for the build status
[12:24:15.261] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:15.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:54:0) after 1m0s
[12:25:15.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:54:0)
[12:25:15.319] Timer tick, asking Buildbucket for the build status
[12:25:15.441] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:15.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:55:0) after 1m0s
[12:26:15.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:55:0)
[12:26:15.468] Timer tick, asking Buildbucket for the build status
[12:26:15.617] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:15.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:56:0) after 1m0s
[12:27:15.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:56:0)
[12:27:15.721] Timer tick, asking Buildbucket for the build status
[12:27:15.782] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:15.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:57:0) after 1m0s
[12:28:15.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:57:0)
[12:28:15.812] Timer tick, asking Buildbucket for the build status
[12:28:15.927] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:15.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:58:0) after 1m0s
[12:29:15.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:58:0)
[12:29:15.987] Timer tick, asking Buildbucket for the build status
[12:29:16.373] Build 8886760706947765824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:16.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052190769367585296:59:0) after 1m0s
[12:29:39.159] Received PubSub notification, asking Buildbucket for the build status
[12:29:39.295] Build 8886760706947765824: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:29:39.295] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583324978026200",
"created_by": "project:chromium",
"created_ts": "1583321579943192",
"id": "8886760706947765824",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c54304438b48311c1c258d8ab2e66622d5ba9f19\"}}",
"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-central1-b-8-22-48mm\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169321, \"got_angle_revision\": \"028a7a725cc63183d87bf248c57ff1dcb33198e1\", \"got_dawn_revision\": \"9b5ecdf536e0da8740eba61fc925f172d51d3c12\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"c54304438b48311c1c258d8ab2e66622d5ba9f19\", \"got_revision_cp\": \"refs/heads/master@{#746731}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"126720bd2e578fec077a57d877ac64c46b18cd52\", \"got_v8_revision\": \"56ff573a6c1416dad552ed26b1724a30a632f4d3\", \"got_v8_revision_cp\": \"refs/heads/8.2.254@{#1}\", \"got_webrtc_revision\": \"80636981052754dcdaaf90a5d83a1cd9eb786dfb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30677}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c54304438b48311c1c258d8ab2e66622d5ba9f19\", \"swarm_hashes_refs/heads/master(at){#746731}_without_patch\": {\"accessibility_unittests\": \"ca866688ef5fc0e7dfdb54d27db5970d91cdc556\", \"angle_unittests\": \"30dea14f3bb7713b4366ad2e57fb2c80e00d78cd\", \"app_shell_unittests\": \"99f88179f91f64b728b1f6d0a6ba7ef114e08eb3\", \"aura_unittests\": \"62ae88fcc2016a27883937c9c66b292927b82afd\", \"base_unittests\": \"fe84d8fbcda7b394a839652cced577da91d9d8a2\", \"base_util_unittests\": \"79214c870d2faca6f88218ddf75a4409f8c93e75\", \"blink_common_unittests\": \"9f28daf4548df0b87ce550dc9ecbd17b1938c34d\", \"blink_fuzzer_unittests\": \"5f08412507f8e08947a4ab9322605af1b51b92dd\", \"blink_heap_unittests\": \"77b0dce41f1e388357578778a49352f5498f45c3\", \"blink_platform_unittests\": \"dcce37b66c8fe577e8861c99e7a98b2a0916a825\", \"blink_python_tests\": \"814e4106d238c7fd3659e9b1c38ea91498be54ed\", \"blink_unittests\": \"94c65a77ae5964dfed04791da63342899e74dd5a\", \"blink_web_tests\": \"aea9a10434c444971e7294f87bea8e20e6884f2c\", \"boringssl_crypto_tests\": \"2ca68ab5b2b45a6047986fe905f5d466127e0738\", \"boringssl_ssl_tests\": \"2d3e82d45c6627ae319253cca72e6641eefc3e5a\", \"browser_tests\": \"c9bfbf7cab6852f3d78cae112b4be615b9a9e235\", \"cacheinvalidation_unittests\": \"2578a579287a4f0bd47449cf88960f8cb5a9a745\", \"capture_unittests\": \"5f63f8ac77fefe5e89ce9f1ff34face6c6ba9658\", \"cast_unittests\": \"177629f30fde7210e5a8b083864d243db30b6df8\", \"cc_unittests\": \"1ef580eefbf4b21ea9c77c5fffa354840f130f74\", \"chrome_app_unittests\": \"5d6054076a1424c4e9358e762eee75e315ce9b08\", \"chromedriver_unittests\": \"bc14b2170f4157e531df43d9c63d83aa89453c19\", \"components_browsertests\": \"9b401103d0a207a216607b866650fb62d06ad737\", \"components_unittests\": \"edd1922cc7012455d4c4dd61ba119097d87db10c\", \"compositor_unittests\": \"1ae7619709c4124dd5d247960632dffaff5fa4ab\", \"content_browsertests\": \"3e6b8adc1828daecbf049f81e032420cb6ffdf05\", \"content_shell_crash_test\": \"b229b6f7c41f9c1986328c5fa2100bebb3e92abd\", \"content_unittests\": \"beee63d7f19b9f648e71937b5c842b8f4694fcb6\", \"crashpad_tests\": \"cb921513c670ffc86c5a2a974781ce0aad02fd6e\", \"cronet_tests\": \"317d0d3e2830e3c514be2bde19688183df406958\", \"cronet_unittests\": \"c9f1ab2813cf07dd75a92d84250bee3a0bd3a51d\", \"crypto_unittests\": \"57807d0631e2a693234f70d6433d670c3bf85e06\", \"dbus_unittests\": \"8c01fc58428e2702a79c16d38d36f414cbee5fe7\", \"device_unittests\": \"b01bed8c0cbe883e4f5f084c1dc253bea1011fbd\", \"display_unittests\": \"2fe913e339e8fce5669a2b34f81a1ea481716546\", \"events_unittests\": \"e26f936512c4a6889f18b08049cbd91f5c854b74\", \"extensions_browsertests\": \"8d9355cbfe7c700282c5c56348a56d0fa1ad064f\", \"extensions_unittests\": \"e9fa4b0399cecaac3368e1359f636d86bd299dc9\", \"filesystem_service_unittests\": \"03deea9a72460275cba2edfaadbbeb2189ddb0bf\", \"flatbuffers_unittests\": \"9b972b84314b0e944fad99f4c5be3f50c351ec0c\", \"gcm_unit_tests\": \"2d9ebc641816e9e78882d4ffc03bc376fc7d5a0c\", \"gfx_unittests\": \"c944ad3e86d4309dfe563d2787e04325c387d118\", \"gin_unittests\": \"20ae819a025d08be39fa8a4c635a270a5e8f8d3c\", \"google_apis_unittests\": \"40494292c81b0e9170746fb76144ff60a86bbfee\", \"gpu_unittests\": \"8d5a83ff8d5d785f0a7a6dc2f7084bdb50678dbc\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"1a579480a7fb3c697a53e6f02a50d0cadb81aaa0\", \"headless_browsertests\": \"790e111d9e3b6c4165cfa18030310addefa228ab\", \"headless_unittests\": \"c88a79705a5c9e7118cb832fc0eb0641dc746ae8\", \"interactive_ui_tests\": \"2628446a80fdf5aacc900d17e3259ea7ca1a2076\", \"ipc_tests\": \"a0d14ece26b1b39e78bb51614da1b77ccb8854ab\", \"jingle_unittests\": \"1f58b48c15c33f5665fceb293542fd8db47dada9\", \"latency_unittests\": \"111612f159cf3c22aaeecd65fd58e2ff0879b422\", \"libjingle_xmpp_unittests\": \"8bb71646450ea6d4b3c5dfe3bb01377470744ebf\", \"media_blink_unittests\": \"1c91d497831d55b97d3583098874cda0db6c26c2\", \"media_service_unittests\": \"4be2148b3454822d2baad2b72a885fb1b562abb0\", \"media_unittests\": \"9fc55d651d46125e20432349230346febad2941e\", \"message_center_unittests\": \"62fd5afc79372fa4311ff8d087975a117da4d172\", \"metrics_python_tests\": \"6f4827a682031dfe9c89b53acef317ca61423b94\", \"midi_unittests\": \"67e56b5785a401046bd98156dda76c84cfb18b07\", \"mojo_core_unittests\": \"d6c403c92be501da99215495286762a964ebbee0\", \"mojo_unittests\": \"66494513af972174d34bc6b9650caf175d30e8ee\", \"nacl_helper_nonsfi_unittests\": \"24801c3beff84f8f7907558312e6f6a988e0993b\", \"nacl_loader_unittests\": \"e7e928eb732731b9c42a5c352d613515235c4ddc\", \"native_theme_unittests\": \"7a9551bdbbbfb0968bbd9260a6e4f69b215b9722\", \"net_unittests\": \"21bdebe93262cbf2dea22dc7daf4a87523ee134b\", \"pdf_unittests\": \"a33c089186793f50e6618065bfd70c74366f496c\", \"perfetto_unittests\": \"7a8440339621c63889a18823d0c208cb9ec4a540\", \"ppapi_unittests\": \"c8557fc90a4c96665b1cea892e84427898838218\", \"printing_unittests\": \"9b868e0bf1e279cec6c0ec02d41059f30f8411ff\", \"remoting_unittests\": \"fae5516a99fc71684675c765546d6a1e3025eb12\", \"sandbox_linux_unittests\": \"46405cf6be84ed4b4f0d7c9835a844f17935127c\", \"service_manager_unittests\": \"c928bf60185a2aea876132640964a29e38fb85d6\", \"services_unittests\": \"0134baf8d101c2025fd3c426916f12c927219568\", \"shell_dialogs_unittests\": \"540621f823fae027e42416579145ea8c2b63178c\", \"skia_unittests\": \"bb45d5cb66401d468248d426a348ff01b2287cd7\", \"snapshot_unittests\": \"460ab517589cc4bbccd14c34834903fe3e5e76b8\", \"sql_unittests\": \"db89a97820d4fda1abc46ab53923ade20c2f9880\", \"storage_unittests\": \"aa79f6d8389f4c2ea41c7d3c7b5e49dbaec5819e\", \"sync_integration_tests\": \"42cabf68bfb2eb9a8fb18d94139e4206ad995062\", \"telemetry_gpu_unittests\": \"4ac63032069b7c5e00e0ca60c9f2c54e75d37318\", \"telemetry_perf_unittests\": \"067f6f621e9cd843b7c285b9c5a0f968a7fdcfbe\", \"telemetry_unittests\": \"0b0a9e2b6c94bd9f727b837f7923e3d01e6cb486\", \"traffic_annotation_auditor_unittests\": \"c07c68b921ad85f7e49017323ff992e44f2d583f\", \"ui_base_unittests\": \"0431d70044ef37f3a69ae0bc9205aabbd7681559\", \"ui_touch_selection_unittests\": \"64e41201ea83031fdd22859e4826e316d97143d6\", \"unit_tests\": \"8942e5ab8a8be03189562207738eadbc6244933b\", \"url_unittests\": \"d3103574aa07446156f12b5fc178165260352672\", \"views_perftests\": \"e23980e68dd96ecf8292e815dce80a286ad15694\", \"views_unittests\": \"5f290f8c105b8d2dc369befcb130071d98aabab0\", \"viz_unittests\": \"44d82aa0a59ba6cef27afa9f5ae66e33a437d70e\", \"vr_common_unittests\": \"390d625458ac483118faed8d3ced93bd41dc380b\", \"vr_pixeltests\": \"1ba2c7bac8ad6698b7ca2bd3bd6b9a90ff4f2830\", \"webdriver_wpt_tests\": \"3aa14b38055b2ca92317e92ec72766a822f0b0ff\", \"weblayer_browsertests\": \"dcff7cc97e37ff450f8dead1ac7cba7b336ff0c2\", \"wm_unittests\": \"9446e659ca54253955103114073d50a6cafa829c\", \"wtf_unittests\": \"07d6a8dd77438f3152987fcc2c976470fea425b1\", \"xr_browser_tests\": \"80583e9c70f60925d741ddbb55364bd0a51c7563\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_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-central1-b-8-22-48mm\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583321882871431",
"status": "COMPLETED",
"status_changed_ts": "1583324978671495",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169321",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c54304438b48311c1c258d8ab2e66622d5ba9f19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c54304438b48311c1c258d8ab2e66622d5ba9f19",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052190769367585296",
"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/8886760706947765824/+/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:4abe238df48a9c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583324978680641",
"url": "https://ci.chromium.org/b/8886760706947765824",
"utcnow_ts": "1583324979279837"
}
}
[12:29:39.295] Invocation finished in 56m41.043628191s with status SUCCEEDED