[18:26:14.204] New invocation is queued and will start shortly
[18:26:15.307] Starting the invocation (attempt 1)
[18:26:15.350] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:26:15.350] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:26:15.350] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018462697441905824",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3dd06e287d1341fa5c42a721a6e0399037cc9859\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018462697441905824",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/3dd06e287d1341fa5c42a721a6e0399037cc9859",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3dd06e287d1341fa5c42a721a6e0399037cc9859",
"gitiles_ref:refs/heads/master"
]
}
[18:26:16.199] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615487175454904",
"id": "8853032635469521472",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3dd06e287d1341fa5c42a721a6e0399037cc9859\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615487175946828",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22954",
"builder:linux-chromeos-dbg",
"buildset:commit/git/3dd06e287d1341fa5c42a721a6e0399037cc9859",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3dd06e287d1341fa5c42a721a6e0399037cc9859",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018462697441905824",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853032635469521472/+/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": "1615487175946963",
"url": "https://ci.chromium.org/b/8853032635469521472",
"utcnow_ts": "1615487176146178"
}
}
[18:26:16.199] Task URL: https://ci.chromium.org/b/8853032635469521472
[18:26:16.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:2:0) after 1m0s
[18:26:39.728] Received PubSub notification, asking Buildbucket for the build status
[18:26:39.790] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:16.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:2:0)
[18:27:16.201] Timer tick, asking Buildbucket for the build status
[18:27:16.353] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:16.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:4:0) after 1m0s
[18:28:16.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:4:0)
[18:28:16.378] Timer tick, asking Buildbucket for the build status
[18:28:16.443] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:16.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:5:0) after 1m0s
[18:29:16.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:5:0)
[18:29:16.453] Timer tick, asking Buildbucket for the build status
[18:29:16.521] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:16.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:6:0) after 1m0s
[18:30:16.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:6:0)
[18:30:16.583] Timer tick, asking Buildbucket for the build status
[18:30:16.734] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:16.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:7:0) after 1m0s
[18:31:16.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:7:0)
[18:31:16.860] Timer tick, asking Buildbucket for the build status
[18:31:16.955] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:16.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:8:0) after 1m0s
[18:32:16.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:8:0)
[18:32:16.976] Timer tick, asking Buildbucket for the build status
[18:32:17.215] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:17.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:9:0) after 1m0s
[18:33:17.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:9:0)
[18:33:17.250] Timer tick, asking Buildbucket for the build status
[18:33:17.476] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:17.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:10:0) after 1m0s
[18:34:17.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:10:0)
[18:34:17.986] Timer tick, asking Buildbucket for the build status
[18:34:18.136] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:18.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:11:0) after 1m0s
[18:35:18.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:11:0)
[18:35:18.315] Timer tick, asking Buildbucket for the build status
[18:35:18.373] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:18.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:12:0) after 1m0s
[18:36:18.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:12:0)
[18:36:18.611] Timer tick, asking Buildbucket for the build status
[18:36:18.807] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:18.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:13:0) after 1m0s
[18:37:19.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:13:0)
[18:37:19.026] Timer tick, asking Buildbucket for the build status
[18:37:19.112] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:19.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:14:0) after 1m0s
[18:38:19.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:14:0)
[18:38:19.158] Timer tick, asking Buildbucket for the build status
[18:38:19.228] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:19.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:15:0) after 1m0s
[18:39:19.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:15:0)
[18:39:19.563] Timer tick, asking Buildbucket for the build status
[18:39:19.650] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:19.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:16:0) after 1m0s
[18:40:19.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:16:0)
[18:40:19.804] Timer tick, asking Buildbucket for the build status
[18:40:20.141] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:20.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:17:0) after 1m0s
[18:41:20.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:17:0)
[18:41:20.298] Timer tick, asking Buildbucket for the build status
[18:41:20.818] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:20.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:18:0) after 1m0s
[18:42:20.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:18:0)
[18:42:20.866] Timer tick, asking Buildbucket for the build status
[18:42:20.983] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:20.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:19:0) after 1m0s
[18:43:21.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:19:0)
[18:43:21.061] Timer tick, asking Buildbucket for the build status
[18:43:21.312] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:21.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:20:0) after 1m0s
[18:44:21.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:20:0)
[18:44:21.342] Timer tick, asking Buildbucket for the build status
[18:44:21.413] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:21.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:21:0) after 1m0s
[18:45:21.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:21:0)
[18:45:21.464] Timer tick, asking Buildbucket for the build status
[18:45:24.032] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:24.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:22:0) after 1m0s
[18:46:24.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:22:0)
[18:46:24.067] Timer tick, asking Buildbucket for the build status
[18:46:26.446] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:26.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:23:0) after 1m0s
[18:47:26.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:23:0)
[18:47:26.571] Timer tick, asking Buildbucket for the build status
[18:47:26.640] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:26.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:24:0) after 1m0s
[18:48:26.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:24:0)
[18:48:26.764] Timer tick, asking Buildbucket for the build status
[18:48:26.843] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:26.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:25:0) after 1m0s
[18:49:26.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:25:0)
[18:49:26.905] Timer tick, asking Buildbucket for the build status
[18:49:26.979] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:26.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:26:0) after 1m0s
[18:50:27.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:26:0)
[18:50:27.006] Timer tick, asking Buildbucket for the build status
[18:50:27.147] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:27.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:27:0) after 1m0s
[18:51:27.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:27:0)
[18:51:27.197] Timer tick, asking Buildbucket for the build status
[18:51:27.316] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:27.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:28:0) after 1m0s
[18:52:27.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:28:0)
[18:52:27.527] Timer tick, asking Buildbucket for the build status
[18:52:27.821] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:27.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:29:0) after 1m0s
[18:53:27.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:29:0)
[18:53:27.967] Timer tick, asking Buildbucket for the build status
[18:53:28.175] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:28.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:30:0) after 1m0s
[18:54:28.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:30:0)
[18:54:28.220] Timer tick, asking Buildbucket for the build status
[18:54:28.300] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:28.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:31:0) after 1m0s
[18:55:28.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:31:0)
[18:55:28.295] Timer tick, asking Buildbucket for the build status
[18:55:28.374] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:28.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:32:0) after 1m0s
[18:56:28.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:32:0)
[18:56:28.455] Timer tick, asking Buildbucket for the build status
[18:56:28.712] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:28.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:33:0) after 1m0s
[18:57:28.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:33:0)
[18:57:28.772] Timer tick, asking Buildbucket for the build status
[18:57:28.842] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:28.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:34:0) after 1m0s
[18:58:28.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:34:0)
[18:58:28.936] Timer tick, asking Buildbucket for the build status
[18:58:28.995] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:28.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:35:0) after 1m0s
[18:59:29.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:35:0)
[18:59:29.086] Timer tick, asking Buildbucket for the build status
[18:59:30.206] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:30.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:36:0) after 1m0s
[19:00:30.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:36:0)
[19:00:30.337] Timer tick, asking Buildbucket for the build status
[19:00:30.442] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:30.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:37:0) after 1m0s
[19:01:30.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:37:0)
[19:01:30.491] Timer tick, asking Buildbucket for the build status
[19:01:30.581] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:30.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:38:0) after 1m0s
[19:02:30.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:38:0)
[19:02:30.641] Timer tick, asking Buildbucket for the build status
[19:02:30.719] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:30.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:39:0) after 1m0s
[19:03:30.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:39:0)
[19:03:30.885] Timer tick, asking Buildbucket for the build status
[19:03:30.990] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:30.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:40:0) after 1m0s
[19:04:31.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:40:0)
[19:04:31.040] Timer tick, asking Buildbucket for the build status
[19:04:31.334] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:31.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:41:0) after 1m0s
[19:05:31.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:41:0)
[19:05:31.464] Timer tick, asking Buildbucket for the build status
[19:05:31.539] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:31.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:42:0) after 1m0s
[19:06:31.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:42:0)
[19:06:31.607] Timer tick, asking Buildbucket for the build status
[19:06:31.759] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:31.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:43:0) after 1m0s
[19:07:31.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:43:0)
[19:07:31.852] Timer tick, asking Buildbucket for the build status
[19:07:32.147] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:32.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:44:0) after 1m0s
[19:08:32.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:44:0)
[19:08:32.231] Timer tick, asking Buildbucket for the build status
[19:08:32.338] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:32.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:45:0) after 1m0s
[19:09:32.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:45:0)
[19:09:32.477] Timer tick, asking Buildbucket for the build status
[19:09:32.647] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:32.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:46:0) after 1m0s
[19:10:32.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:46:0)
[19:10:32.715] Timer tick, asking Buildbucket for the build status
[19:10:32.828] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:32.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:47:0) after 1m0s
[19:11:33.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:47:0)
[19:11:33.038] Timer tick, asking Buildbucket for the build status
[19:11:33.122] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:33.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:48:0) after 1m0s
[19:12:33.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:48:0)
[19:12:33.141] Timer tick, asking Buildbucket for the build status
[19:12:33.389] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:33.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:49:0) after 1m0s
[19:13:33.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:49:0)
[19:13:33.429] Timer tick, asking Buildbucket for the build status
[19:13:33.505] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:33.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:50:0) after 1m0s
[19:14:33.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:50:0)
[19:14:33.523] Timer tick, asking Buildbucket for the build status
[19:14:33.597] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:33.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:51:0) after 1m0s
[19:15:33.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:51:0)
[19:15:33.632] Timer tick, asking Buildbucket for the build status
[19:15:33.710] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:33.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:52:0) after 1m0s
[19:16:33.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:52:0)
[19:16:33.751] Timer tick, asking Buildbucket for the build status
[19:16:33.840] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:33.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:53:0) after 1m0s
[19:17:33.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:53:0)
[19:17:33.869] Timer tick, asking Buildbucket for the build status
[19:17:33.959] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:33.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:54:0) after 1m0s
[19:18:33.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:54:0)
[19:18:33.978] Timer tick, asking Buildbucket for the build status
[19:18:34.418] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:34.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:55:0) after 1m0s
[19:19:34.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:55:0)
[19:19:34.467] Timer tick, asking Buildbucket for the build status
[19:19:34.755] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:34.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:56:0) after 1m0s
[19:20:34.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:56:0)
[19:20:34.751] Timer tick, asking Buildbucket for the build status
[19:20:34.826] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:34.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:57:0) after 1m0s
[19:21:34.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:57:0)
[19:21:34.910] Timer tick, asking Buildbucket for the build status
[19:21:35.035] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:35.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:58:0) after 1m0s
[19:22:35.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:58:0)
[19:22:35.096] Timer tick, asking Buildbucket for the build status
[19:22:35.318] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:35.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:59:0) after 1m0s
[19:23:35.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:59:0)
[19:23:35.311] Timer tick, asking Buildbucket for the build status
[19:23:35.520] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:35.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:60:0) after 1m0s
[19:24:35.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:60:0)
[19:24:35.599] Timer tick, asking Buildbucket for the build status
[19:24:35.673] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:35.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:61:0) after 1m0s
[19:25:35.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:61:0)
[19:25:35.699] Timer tick, asking Buildbucket for the build status
[19:25:35.870] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:35.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:62:0) after 1m0s
[19:26:35.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:62:0)
[19:26:35.909] Timer tick, asking Buildbucket for the build status
[19:26:36.004] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:36.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:63:0) after 1m0s
[19:27:36.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:63:0)
[19:27:36.034] Timer tick, asking Buildbucket for the build status
[19:27:36.455] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:36.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:64:0) after 1m0s
[19:28:36.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:64:0)
[19:28:36.473] Timer tick, asking Buildbucket for the build status
[19:28:36.557] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:36.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:65:0) after 1m0s
[19:29:36.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:65:0)
[19:29:36.564] Timer tick, asking Buildbucket for the build status
[19:29:36.873] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:36.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:66:0) after 1m0s
[19:30:36.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:66:0)
[19:30:36.905] Timer tick, asking Buildbucket for the build status
[19:30:36.981] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:36.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:67:0) after 1m0s
[19:31:37.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:67:0)
[19:31:37.007] Timer tick, asking Buildbucket for the build status
[19:31:37.109] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:37.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:68:0) after 1m0s
[19:32:37.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:68:0)
[19:32:37.139] Timer tick, asking Buildbucket for the build status
[19:32:37.240] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:37.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:69:0) after 1m0s
[19:33:37.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:69:0)
[19:33:37.252] Timer tick, asking Buildbucket for the build status
[19:33:37.337] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:37.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:70:0) after 1m0s
[19:34:37.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:70:0)
[19:34:37.447] Timer tick, asking Buildbucket for the build status
[19:34:37.525] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:37.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:71:0) after 1m0s
[19:35:37.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:71:0)
[19:35:37.660] Timer tick, asking Buildbucket for the build status
[19:35:37.740] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:37.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:72:0) after 1m0s
[19:36:37.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:72:0)
[19:36:37.823] Timer tick, asking Buildbucket for the build status
[19:36:37.918] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:37.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:73:0) after 1m0s
[19:37:37.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:73:0)
[19:37:37.937] Timer tick, asking Buildbucket for the build status
[19:37:38.026] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:38.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:74:0) after 1m0s
[19:38:38.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:74:0)
[19:38:38.000] Timer tick, asking Buildbucket for the build status
[19:38:38.066] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:38.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:75:0) after 1m0s
[19:39:38.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:75:0)
[19:39:38.106] Timer tick, asking Buildbucket for the build status
[19:39:38.251] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:38.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:76:0) after 1m0s
[19:40:38.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:76:0)
[19:40:38.317] Timer tick, asking Buildbucket for the build status
[19:40:38.458] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:38.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:77:0) after 1m0s
[19:41:38.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:77:0)
[19:41:38.529] Timer tick, asking Buildbucket for the build status
[19:41:39.015] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:39.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:78:0) after 1m0s
[19:42:39.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:78:0)
[19:42:39.028] Timer tick, asking Buildbucket for the build status
[19:42:39.310] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:39.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:79:0) after 1m0s
[19:43:39.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:79:0)
[19:43:39.378] Timer tick, asking Buildbucket for the build status
[19:43:39.534] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:39.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:80:0) after 1m0s
[19:44:39.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:80:0)
[19:44:39.594] Timer tick, asking Buildbucket for the build status
[19:44:39.764] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:39.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:81:0) after 1m0s
[19:45:39.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:81:0)
[19:45:39.773] Timer tick, asking Buildbucket for the build status
[19:45:40.149] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:40.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:82:0) after 1m0s
[19:46:40.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:82:0)
[19:46:40.257] Timer tick, asking Buildbucket for the build status
[19:46:40.373] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:40.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:83:0) after 1m0s
[19:47:40.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:83:0)
[19:47:40.423] Timer tick, asking Buildbucket for the build status
[19:47:40.753] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:40.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:84:0) after 1m0s
[19:48:40.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:84:0)
[19:48:40.754] Timer tick, asking Buildbucket for the build status
[19:48:42.027] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:42.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:85:0) after 1m0s
[19:49:42.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:85:0)
[19:49:42.048] Timer tick, asking Buildbucket for the build status
[19:49:42.134] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:42.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:86:0) after 1m0s
[19:50:42.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:86:0)
[19:50:42.209] Timer tick, asking Buildbucket for the build status
[19:50:42.360] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:42.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:87:0) after 1m0s
[19:51:42.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:87:0)
[19:51:42.371] Timer tick, asking Buildbucket for the build status
[19:51:42.464] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:42.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:88:0) after 1m0s
[19:52:42.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:88:0)
[19:52:42.535] Timer tick, asking Buildbucket for the build status
[19:52:42.804] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:42.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:89:0) after 1m0s
[19:53:42.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:89:0)
[19:53:42.849] Timer tick, asking Buildbucket for the build status
[19:53:42.930] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:42.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:90:0) after 1m0s
[19:54:42.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:90:0)
[19:54:42.979] Timer tick, asking Buildbucket for the build status
[19:54:43.056] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:43.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:91:0) after 1m0s
[19:55:43.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:91:0)
[19:55:43.123] Timer tick, asking Buildbucket for the build status
[19:55:43.216] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:43.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:92:0) after 1m0s
[19:56:43.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:92:0)
[19:56:43.248] Timer tick, asking Buildbucket for the build status
[19:56:43.348] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:43.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:93:0) after 1m0s
[19:57:43.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:93:0)
[19:57:43.450] Timer tick, asking Buildbucket for the build status
[19:57:43.521] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:43.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:94:0) after 1m0s
[19:58:43.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:94:0)
[19:58:43.707] Timer tick, asking Buildbucket for the build status
[19:58:44.103] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:44.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:95:0) after 1m0s
[19:59:44.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:95:0)
[19:59:44.234] Timer tick, asking Buildbucket for the build status
[19:59:44.307] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:44.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:96:0) after 1m0s
[20:00:44.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:96:0)
[20:00:44.405] Timer tick, asking Buildbucket for the build status
[20:00:44.480] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:44.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:97:0) after 1m0s
[20:01:44.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:97:0)
[20:01:44.544] Timer tick, asking Buildbucket for the build status
[20:01:44.647] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:44.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:98:0) after 1m0s
[20:02:44.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:98:0)
[20:02:44.706] Timer tick, asking Buildbucket for the build status
[20:02:44.918] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:44.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:99:0) after 1m0s
[20:03:45.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:99:0)
[20:03:45.041] Timer tick, asking Buildbucket for the build status
[20:03:45.137] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:45.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:100:0) after 1m0s
[20:04:45.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:100:0)
[20:04:45.220] Timer tick, asking Buildbucket for the build status
[20:04:45.570] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:45.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:101:0) after 1m0s
[20:05:45.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:101:0)
[20:05:45.596] Timer tick, asking Buildbucket for the build status
[20:05:45.761] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:45.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:102:0) after 1m0s
[20:06:45.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:102:0)
[20:06:45.871] Timer tick, asking Buildbucket for the build status
[20:06:45.964] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:45.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:103:0) after 1m0s
[20:07:45.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:103:0)
[20:07:45.988] Timer tick, asking Buildbucket for the build status
[20:07:46.203] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:46.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:104:0) after 1m0s
[20:08:46.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:104:0)
[20:08:46.245] Timer tick, asking Buildbucket for the build status
[20:08:46.609] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:46.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:105:0) after 1m0s
[20:09:46.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:105:0)
[20:09:46.696] Timer tick, asking Buildbucket for the build status
[20:09:46.776] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:46.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:106:0) after 1m0s
[20:10:46.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:106:0)
[20:10:46.850] Timer tick, asking Buildbucket for the build status
[20:10:46.923] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:46.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:107:0) after 1m0s
[20:11:47.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:107:0)
[20:11:47.020] Timer tick, asking Buildbucket for the build status
[20:11:47.643] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:47.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:108:0) after 1m0s
[20:12:47.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:108:0)
[20:12:47.695] Timer tick, asking Buildbucket for the build status
[20:12:47.933] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:47.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:109:0) after 1m0s
[20:13:47.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:109:0)
[20:13:47.978] Timer tick, asking Buildbucket for the build status
[20:13:48.067] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:48.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:110:0) after 1m0s
[20:14:48.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:110:0)
[20:14:48.095] Timer tick, asking Buildbucket for the build status
[20:14:48.174] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:48.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:111:0) after 1m0s
[20:15:48.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:111:0)
[20:15:48.305] Timer tick, asking Buildbucket for the build status
[20:15:48.410] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:48.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:112:0) after 1m0s
[20:16:48.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:112:0)
[20:16:48.447] Timer tick, asking Buildbucket for the build status
[20:16:48.535] Build 8853032635469521472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:48.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018462697441905824:113:0) after 1m0s
[20:17:02.440] Received PubSub notification, asking Buildbucket for the build status
[20:17:02.554] Build 8853032635469521472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:17:02.555] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615493821562401",
"created_by": "project:chromium",
"created_ts": "1615487175454904",
"id": "8853032635469521472",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3dd06e287d1341fa5c42a721a6e0399037cc9859\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"3dd06e287d1341fa5c42a721a6e0399037cc9859\", \"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-central1-b-8-73-zami\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22954, \"got_angle_revision\": \"6f74a12b396bb8039f1f2446e62dbe07ec0886a5\", \"got_dawn_revision\": \"b458fc835925a222699fb62358c22047c70bd565\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"3dd06e287d1341fa5c42a721a6e0399037cc9859\", \"got_revision_cp\": \"refs/heads/master@{#862050}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"08ad3359339358d65587e274741c75e3c140c91f\", \"got_v8_revision_cp\": \"refs/heads/9.1.102@{#1}\", \"got_webrtc_revision\": \"14a626af56675c9d95f9fb207d53366a53a95fbd\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33409}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3dd06e287d1341fa5c42a721a6e0399037cc9859\", \"swarm_hashes_refs/heads/master(at){#862050}_without_patch\": {\"absl_hardening_tests\": \"44b8eb87c083bf8f635c1b584876d3ec3c427644\", \"accessibility_unittests\": \"69e4d39f3cecdfdb7381f633601c3c13cf4a6b80\", \"angle_unittests\": \"1e151965750c0ba5c098993d8400829fcc9a435c\", \"app_list_unittests\": \"bf4d978f89ce9fbdbad95d01519ff61b87b6d0f7\", \"app_shell_unittests\": \"75c94de951131b45bff8775ad312b4db402e12ba\", \"ash_unittests\": \"d0482029dbb1ab3f950aec962851e1735bb47552\", \"aura_unittests\": \"3c7b18767751862c67a59fff21d38d8a2a09c7b5\", \"base_unittests\": \"9023a2beda2697565ea56b8ab5dc89dcd86f0d9a\", \"base_util_unittests\": \"d7d0fa2c4e7fb9074c4d8972274508b851ae584d\", \"blink_common_unittests\": \"30205a844e02d38c60a0c13de385946720f2435c\", \"blink_fuzzer_unittests\": \"2bea8d85ab1dbfe2f0c7345ea4b969ea1b4aed71\", \"blink_heap_unittests\": \"cb5b3dd435357cd260cec3b3ff3d0e329dfd927a\", \"blink_platform_unittests\": \"4f468e8ad5ac83e0be1c85bfb4c8a330ba95a17b\", \"blink_unittests\": \"fdf9dcdeb67283354a0bc82fcfcb93f1ef250a36\", \"boringssl_crypto_tests\": \"237373037fa435a9bc6bf64ab52e148d351292c4\", \"boringssl_ssl_tests\": \"7967b309bcdc12d93d4779212291e34b68bc43ec\", \"browser_tests\": \"d5154e5156d57d53d3be7c8496bee0ef99060dc1\", \"capture_unittests\": \"0c753f3a67185b93489e30d042ba027d5feace78\", \"cast_unittests\": \"bab8aa3931a905a0c901f632eade5f82def4be93\", \"cc_unittests\": \"511c8fe8edebf69149b0c14edca74822b1ff0138\", \"chrome_app_unittests\": \"e6de29eabc99ddb5e8b208dbca9c6e5f5550ac9a\", \"chromedriver_unittests\": \"c0edb06b1651a0e5c2066d81857d9033f1a9a2b5\", \"chromeos_components_unittests\": \"5e137b9e1f7b398fde3d1e20f28deed53a0403e5\", \"chromeos_unittests\": \"30fa3d82c58de7610fcb694a1965032ff35de6aa\", \"color_unittests\": \"8f96b4b875c9ffcae556ce7d31b36f9e066599b4\", \"components_browsertests\": \"0c15c4505a12b9699f536e217afecbf1cd7fd260\", \"components_unittests\": \"1c26b1fcff74970a32b77fc0c97de00a4a02b0ad\", \"compositor_unittests\": \"02a2c4d9d9cee25cb4fcab0e9038c4c992364545\", \"content_browsertests\": \"0b441c771d40af46541d2f53f152d1ce652adfa5\", \"content_unittests\": \"7a84c91af8eeff07fbe98cfbd30e96683b945788\", \"crashpad_tests\": \"fe1951e4c129dda62aa0f53f9c43969cc8f9fde0\", \"crypto_unittests\": \"bee82319f68015e2a6996714a5422a542a9cd6cf\", \"dbus_unittests\": \"b7335c15e765daa622577fb574e3907a057675f6\", \"device_unittests\": \"23cadae900a7afe74fa840124375e6a16cda5cc3\", \"display_unittests\": \"f5b988808de3d7a026168c8b749a3643e22706e7\", \"events_unittests\": \"fb4320f34f319541ce1eef8b52d72497e2e8b222\", \"exo_unittests\": \"b9afd5eeb3850dbd643cf2a303dec9674661dbf2\", \"extensions_browsertests\": \"874631f14f86b1336f869e9659521225b9be366b\", \"extensions_unittests\": \"cfe199deb6eb9cc30fe199f73319a9e22c3ded51\", \"filesystem_service_unittests\": \"a8acb6bd568960b3f9e7799dfb8177df4cf8fcd6\", \"gcm_unit_tests\": \"a2675741be5b83b874e2a3d6ea4f71b5af7c4113\", \"gfx_unittests\": \"19812bbd93a23c17d4e0dd3734b084f2050d76f1\", \"gin_unittests\": \"743197e1c873510c5a509f245fdb0537bf07d9d1\", \"gl_unittests_ozone\": \"5104e49eda6e9883e7f452d51afa435a406058a5\", \"google_apis_unittests\": \"48e8387054fb910ffacf8e30ff99a8457b7bc94c\", \"gpu_unittests\": \"de483a627079da47ea41d801d507d01edfa9a0a9\", \"gwp_asan_unittests\": \"ddb7129ef848024fc823bf9b40db9141eba4d139\", \"interactive_ui_tests\": \"faea1cd663964e471509f136c3162053fb836508\", \"ipc_tests\": \"77878c9083b2076a5e5185f71b8e6cd14e118eb4\", \"jingle_unittests\": \"3ba4ada286b10c1ed200adc1ac3fa518f07d361a\", \"keyboard_unittests\": \"3aec906ac3e02bb132783dd30f4046723f8e9f6e\", \"latency_unittests\": \"dc6c51a057a7c753906bcaae09c9793aef9e922c\", \"libjingle_xmpp_unittests\": \"d70cd6948755aa1e52c0ff29d18fb3187875a1bb\", \"liburlpattern_unittests\": \"9b1555e0e006f044986568e7c0ad609496068598\", \"media_blink_unittests\": \"5bc29991318a602a530e8e923aca2edcf960d8e9\", \"media_unittests\": \"c33a7a395dbc03243873e7366c40662dff6a2ac4\", \"message_center_unittests\": \"72f84d4fe2603a7278bb885c3402163641e37b7d\", \"midi_unittests\": \"ae56fdd2d28764052b6c2408ea6f05f250d1e6a1\", \"mojo_core_unittests\": \"8139809520fac8519a6363a6ccf5d35bea593f91\", \"mojo_unittests\": \"5b5e0875dc14875ae20e18728cd3863d7169a8ef\", \"nacl_helper_nonsfi_unittests\": \"5272b77d86efa70a092aef8689352fe50606f0dd\", \"nacl_loader_unittests\": \"3f4993e8ad49f6b218058bd85d1efea87cf4e00a\", \"native_theme_unittests\": \"b5d458f51f1881d61cd1aefa2cf31d900436347b\", \"net_unittests\": \"023d77fe77a5a3159ec321a95e0e380a6cc6c2e9\", \"ozone_gl_unittests\": \"fb2b5e8723eae3a8f5895923c024016e1f01a198\", \"ozone_unittests\": \"bb4968817bae723bb2649ff3ef7d305a19db1d1c\", \"ozone_x11_unittests\": \"21dae651eb1c4d4cdde68448bb1e960545d10dda\", \"pdf_unittests\": \"c4369d3c7e9e88e16b1e025fe7965e69d2e50cdb\", \"perfetto_unittests\": \"788c9a5a064f299ab957a43211a02ae01159cbd5\", \"ppapi_unittests\": \"25c39449322bbb8d52b4adde7996e55632eb4dd0\", \"printing_unittests\": \"83976fdd275ad9e6ccfa99e76b6df3581c3aafed\", \"remoting_unittests\": \"8d14189743e8a06e9f3c21a3c8a4bb420db7e218\", \"sandbox_linux_unittests\": \"3c58351787af3aaa6489f1663556d37de2dba9c1\", \"service_manager_unittests\": \"ed55955d918cf67f21a9fc9cbb109bc403ff5e23\", \"services_unittests\": \"9458d0114841e297575d6f8ef4126595b96dc090\", \"shell_dialogs_unittests\": \"c10eddde8f4db27fea5cc92c5442445310faed95\", \"shell_encryption_unittests\": \"e80a9cec815e32840f95c83fe3688847dda11eed\", \"skia_unittests\": \"073e2fdd3aec665a10d51483d86dbdf8cac326a0\", \"snapshot_unittests\": \"55e3a8f5446f5d59b73e8eb30bef218bf6391fae\", \"sql_unittests\": \"c008c6ac1fd71518763fd1cfea90e13058feb94f\", \"storage_unittests\": \"4fdf3aa55984fd55d5948b6dff30037ea4523445\", \"sync_integration_tests\": \"e229124b6ad45a584f98e6eec1423407947b8c46\", \"traffic_annotation_auditor_unittests\": \"f74a0b0c7ff0d0db3f77164cca7b42e789cb0305\", \"ui_base_unittests\": \"d116cbddf8434ebe865d0b689ae491dc617badf1\", \"ui_chromeos_unittests\": \"e48fa979017321526146a60b7846b8a266c5e588\", \"ui_touch_selection_unittests\": \"a0122a30fffe3cf8f126b7fcad5b3447ac3733f5\", \"unit_tests\": \"029eccb4955207f7db81a5f85f6288f1a68fd4ea\", \"url_unittests\": \"23444987fc671f1b9a78c0d19713e0bc5494d707\", \"usage_time_limit_unittests\": \"964c5e411736b227e57f1c482b35695e571434e5\", \"views_unittests\": \"b3054385b1c1c710c7ccea27d106037bb25170eb\", \"viz_unittests\": \"01f48785b852e769bfb1bf94b01dc65f9e2b6294\", \"wayland_client_tests\": \"1a48bf2318e3f1aca80f99a9f2ac3de8ef0aa990\", \"wm_unittests\": \"22d307fb67b2b2396bb58739586187819b968b63\", \"wtf_unittests\": \"4f93cecd785ece8fb5902de7d1aa62c3809a565a\", \"zlib_unittests\": \"6ed1bbdd7564665ad9441699347d457e4fbca1b4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_4500df524e03abdc7ff29c0f916c0f69df935ae1f41d97a45c59dd04b0afce26_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_b145c774831c5c42cee51952606378f966ad001ff04e0282f5dbcc16172748d9_v2\", \"builder_b9373cfdcc5f43b5e07cc4931fc34027757a424c7183ae2b31ae65ec7718ca12_v2\", \"builder_d78b729059d6d7166c1c60b6c63641496a1541bf700cb46d40203a280149f161_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-central1-b-8-73-zami\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615487198800828",
"status": "COMPLETED",
"status_changed_ts": "1615493821862661",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22954",
"builder:linux-chromeos-dbg",
"buildset:commit/git/3dd06e287d1341fa5c42a721a6e0399037cc9859",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3dd06e287d1341fa5c42a721a6e0399037cc9859",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018462697441905824",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853032635469521472/+/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:523b5b962c7c6d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615493821867434",
"url": "https://ci.chromium.org/b/8853032635469521472",
"utcnow_ts": "1615493822544468"
}
}
[20:17:02.555] Invocation finished in 1h50m48.365421844s with status SUCCEEDED