[13:24:31.494] New invocation is queued and will start shortly
[13:24:32.668] Starting the invocation (attempt 1)
[13:24:32.705] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:24:32.706] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:24:32.706] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018662873442495312",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9b8b4d6fd4b19e704bceda653c0379c94bda9c50\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018662873442495312",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/9b8b4d6fd4b19e704bceda653c0379c94bda9c50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b8b4d6fd4b19e704bceda653c0379c94bda9c50",
"gitiles_ref:refs/heads/master"
]
}
[13:24:34.373] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615296272839988",
"id": "8853232811369619072",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b8b4d6fd4b19e704bceda653c0379c94bda9c50\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615296273965161",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22922",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9b8b4d6fd4b19e704bceda653c0379c94bda9c50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b8b4d6fd4b19e704bceda653c0379c94bda9c50",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018662873442495312",
"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/8853232811369619072/+/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": "1615296273965331",
"url": "https://ci.chromium.org/b/8853232811369619072",
"utcnow_ts": "1615296274337181"
}
}
[13:24:34.373] Task URL: https://ci.chromium.org/b/8853232811369619072
[13:24:34.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:2:0) after 1m0s
[13:24:49.259] Received PubSub notification, asking Buildbucket for the build status
[13:24:49.340] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:34.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:2:0)
[13:25:34.392] Timer tick, asking Buildbucket for the build status
[13:25:34.477] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:34.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:4:0) after 1m0s
[13:26:34.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:4:0)
[13:26:34.497] Timer tick, asking Buildbucket for the build status
[13:26:34.587] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:34.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:5:0) after 1m0s
[13:27:34.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:5:0)
[13:27:34.602] Timer tick, asking Buildbucket for the build status
[13:27:34.842] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:34.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:6:0) after 1m0s
[13:28:34.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:6:0)
[13:28:34.891] Timer tick, asking Buildbucket for the build status
[13:28:34.951] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:34.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:7:0) after 1m0s
[13:29:34.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:7:0)
[13:29:34.966] Timer tick, asking Buildbucket for the build status
[13:29:35.275] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:35.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:8:0) after 1m0s
[13:30:35.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:8:0)
[13:30:35.304] Timer tick, asking Buildbucket for the build status
[13:30:35.361] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:35.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:9:0) after 1m0s
[13:31:35.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:9:0)
[13:31:35.380] Timer tick, asking Buildbucket for the build status
[13:31:35.456] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:35.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:10:0) after 1m0s
[13:32:35.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:10:0)
[13:32:35.472] Timer tick, asking Buildbucket for the build status
[13:32:38.702] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:38.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:11:0) after 1m0s
[13:33:38.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:11:0)
[13:33:38.799] Timer tick, asking Buildbucket for the build status
[13:33:38.945] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:38.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:12:0) after 1m0s
[13:34:39.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:12:0)
[13:34:39.004] Timer tick, asking Buildbucket for the build status
[13:34:39.311] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:39.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:13:0) after 1m0s
[13:35:39.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:13:0)
[13:35:39.363] Timer tick, asking Buildbucket for the build status
[13:35:39.420] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:39.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:14:0) after 1m0s
[13:36:39.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:14:0)
[13:36:39.435] Timer tick, asking Buildbucket for the build status
[13:36:39.499] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:39.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:15:0) after 1m0s
[13:37:39.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:15:0)
[13:37:39.518] Timer tick, asking Buildbucket for the build status
[13:37:39.620] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:39.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:16:0) after 1m0s
[13:38:39.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:16:0)
[13:38:39.623] Timer tick, asking Buildbucket for the build status
[13:38:39.689] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:39.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:17:0) after 1m0s
[13:39:39.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:17:0)
[13:39:39.800] Timer tick, asking Buildbucket for the build status
[13:39:40.227] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:40.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:18:0) after 1m0s
[13:40:40.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:18:0)
[13:40:40.288] Timer tick, asking Buildbucket for the build status
[13:40:40.452] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:40.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:19:0) after 1m0s
[13:41:40.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:19:0)
[13:41:40.542] Timer tick, asking Buildbucket for the build status
[13:41:40.716] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:40.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:20:0) after 1m0s
[13:42:40.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:20:0)
[13:42:40.746] Timer tick, asking Buildbucket for the build status
[13:42:40.837] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:40.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:21:0) after 1m0s
[13:43:40.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:21:0)
[13:43:40.824] Timer tick, asking Buildbucket for the build status
[13:43:40.909] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:40.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:22:0) after 1m0s
[13:44:41.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:22:0)
[13:44:41.027] Timer tick, asking Buildbucket for the build status
[13:44:41.314] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:41.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:23:0) after 1m0s
[13:45:41.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:23:0)
[13:45:41.360] Timer tick, asking Buildbucket for the build status
[13:45:41.423] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:41.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:24:0) after 1m0s
[13:46:41.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:24:0)
[13:46:41.493] Timer tick, asking Buildbucket for the build status
[13:46:41.636] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:41.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:25:0) after 1m0s
[13:47:41.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:25:0)
[13:47:41.663] Timer tick, asking Buildbucket for the build status
[13:47:42.002] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:42.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:26:0) after 1m0s
[13:48:42.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:26:0)
[13:48:42.040] Timer tick, asking Buildbucket for the build status
[13:48:42.129] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:42.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:27:0) after 1m0s
[13:49:42.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:27:0)
[13:49:42.145] Timer tick, asking Buildbucket for the build status
[13:49:42.271] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:42.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:28:0) after 1m0s
[13:50:42.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:28:0)
[13:50:42.300] Timer tick, asking Buildbucket for the build status
[13:50:42.424] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:42.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:29:0) after 1m0s
[13:51:42.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:29:0)
[13:51:42.439] Timer tick, asking Buildbucket for the build status
[13:51:42.650] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:42.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:30:0) after 1m0s
[13:52:42.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:30:0)
[13:52:42.675] Timer tick, asking Buildbucket for the build status
[13:52:44.455] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:44.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:31:0) after 1m0s
[13:53:44.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:31:0)
[13:53:44.506] Timer tick, asking Buildbucket for the build status
[13:53:44.607] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:44.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:32:0) after 1m0s
[13:54:44.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:32:0)
[13:54:44.622] Timer tick, asking Buildbucket for the build status
[13:54:44.934] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:44.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:33:0) after 1m0s
[13:55:45.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:33:0)
[13:55:45.048] Timer tick, asking Buildbucket for the build status
[13:55:45.147] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:45.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:34:0) after 1m0s
[13:56:45.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:34:0)
[13:56:45.210] Timer tick, asking Buildbucket for the build status
[13:56:45.281] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:45.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:35:0) after 1m0s
[13:57:45.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:35:0)
[13:57:45.306] Timer tick, asking Buildbucket for the build status
[13:57:45.405] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:45.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:36:0) after 1m0s
[13:58:45.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:36:0)
[13:58:45.465] Timer tick, asking Buildbucket for the build status
[13:58:45.525] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:45.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:37:0) after 1m0s
[13:59:45.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:37:0)
[13:59:45.627] Timer tick, asking Buildbucket for the build status
[13:59:45.693] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:45.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:38:0) after 1m0s
[14:00:45.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:38:0)
[14:00:45.711] Timer tick, asking Buildbucket for the build status
[14:00:45.798] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:45.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:39:0) after 1m0s
[14:01:45.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:39:0)
[14:01:45.892] Timer tick, asking Buildbucket for the build status
[14:01:46.042] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:46.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:40:0) after 1m0s
[14:02:46.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:40:0)
[14:02:46.054] Timer tick, asking Buildbucket for the build status
[14:02:46.409] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:46.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:41:0) after 1m0s
[14:03:46.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:41:0)
[14:03:46.422] Timer tick, asking Buildbucket for the build status
[14:03:46.503] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:46.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:42:0) after 1m0s
[14:04:46.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:42:0)
[14:04:46.514] Timer tick, asking Buildbucket for the build status
[14:04:46.759] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:46.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:43:0) after 1m0s
[14:05:46.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:43:0)
[14:05:46.875] Timer tick, asking Buildbucket for the build status
[14:05:47.163] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:47.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:44:0) after 1m0s
[14:06:47.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:44:0)
[14:06:47.172] Timer tick, asking Buildbucket for the build status
[14:06:47.247] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:47.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:45:0) after 1m0s
[14:07:47.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:45:0)
[14:07:47.290] Timer tick, asking Buildbucket for the build status
[14:07:47.421] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:47.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:46:0) after 1m0s
[14:08:47.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:46:0)
[14:08:47.452] Timer tick, asking Buildbucket for the build status
[14:08:47.530] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:47.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:47:0) after 1m0s
[14:09:47.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:47:0)
[14:09:47.552] Timer tick, asking Buildbucket for the build status
[14:09:47.855] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:47.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:48:0) after 1m0s
[14:10:47.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:48:0)
[14:10:47.875] Timer tick, asking Buildbucket for the build status
[14:10:48.083] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:48.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:49:0) after 1m0s
[14:11:49.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:49:0)
[14:11:49.179] Timer tick, asking Buildbucket for the build status
[14:11:49.266] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:49.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:50:0) after 1m0s
[14:12:49.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:50:0)
[14:12:49.296] Timer tick, asking Buildbucket for the build status
[14:12:49.379] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:49.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:51:0) after 1m0s
[14:13:49.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:51:0)
[14:13:49.422] Timer tick, asking Buildbucket for the build status
[14:13:49.743] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:49.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:52:0) after 1m0s
[14:14:49.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:52:0)
[14:14:49.767] Timer tick, asking Buildbucket for the build status
[14:14:49.885] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:49.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:53:0) after 1m0s
[14:15:49.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:53:0)
[14:15:49.950] Timer tick, asking Buildbucket for the build status
[14:15:50.061] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:50.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:54:0) after 1m0s
[14:16:50.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:54:0)
[14:16:50.062] Timer tick, asking Buildbucket for the build status
[14:16:50.140] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:50.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:55:0) after 1m0s
[14:17:50.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:55:0)
[14:17:50.162] Timer tick, asking Buildbucket for the build status
[14:17:50.237] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:50.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:56:0) after 1m0s
[14:18:50.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:56:0)
[14:18:50.292] Timer tick, asking Buildbucket for the build status
[14:18:50.377] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:50.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:57:0) after 1m0s
[14:19:50.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:57:0)
[14:19:50.484] Timer tick, asking Buildbucket for the build status
[14:19:50.594] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:50.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:58:0) after 1m0s
[14:20:50.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:58:0)
[14:20:50.641] Timer tick, asking Buildbucket for the build status
[14:20:51.044] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:51.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:59:0) after 1m0s
[14:21:51.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:59:0)
[14:21:51.156] Timer tick, asking Buildbucket for the build status
[14:21:51.408] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:51.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:60:0) after 1m0s
[14:22:51.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:60:0)
[14:22:51.491] Timer tick, asking Buildbucket for the build status
[14:22:51.664] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:51.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:61:0) after 1m0s
[14:23:51.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:61:0)
[14:23:51.731] Timer tick, asking Buildbucket for the build status
[14:23:52.273] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:52.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:62:0) after 1m0s
[14:24:52.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:62:0)
[14:24:52.830] Timer tick, asking Buildbucket for the build status
[14:24:52.944] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:52.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:63:0) after 1m0s
[14:25:53.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:63:0)
[14:25:53.127] Timer tick, asking Buildbucket for the build status
[14:25:53.213] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:53.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:64:0) after 1m0s
[14:26:53.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:64:0)
[14:26:53.325] Timer tick, asking Buildbucket for the build status
[14:26:53.524] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:53.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:65:0) after 1m0s
[14:27:53.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:65:0)
[14:27:53.586] Timer tick, asking Buildbucket for the build status
[14:27:53.701] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:53.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:66:0) after 1m0s
[14:28:54.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:66:0)
[14:28:54.151] Timer tick, asking Buildbucket for the build status
[14:28:54.270] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:54.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:67:0) after 1m0s
[14:29:54.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:67:0)
[14:29:54.389] Timer tick, asking Buildbucket for the build status
[14:29:54.472] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:54.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:68:0) after 1m0s
[14:30:54.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:68:0)
[14:30:54.580] Timer tick, asking Buildbucket for the build status
[14:30:54.666] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:54.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:69:0) after 1m0s
[14:31:54.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:69:0)
[14:31:54.901] Timer tick, asking Buildbucket for the build status
[14:31:55.101] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:55.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:70:0) after 1m0s
[14:32:55.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:70:0)
[14:32:55.194] Timer tick, asking Buildbucket for the build status
[14:32:55.297] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:55.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:71:0) after 1m0s
[14:33:55.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:71:0)
[14:33:55.411] Timer tick, asking Buildbucket for the build status
[14:33:55.602] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:55.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:72:0) after 1m0s
[14:34:55.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:72:0)
[14:34:55.653] Timer tick, asking Buildbucket for the build status
[14:34:58.145] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:58.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:73:0) after 1m0s
[14:35:58.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:73:0)
[14:35:58.375] Timer tick, asking Buildbucket for the build status
[14:35:58.611] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:58.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:74:0) after 1m0s
[14:36:59.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:74:0)
[14:36:59.868] Timer tick, asking Buildbucket for the build status
[14:36:59.937] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:59.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:75:0) after 1m0s
[14:38:00.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:75:0)
[14:38:00.570] Timer tick, asking Buildbucket for the build status
[14:38:00.698] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:00.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:76:0) after 1m0s
[14:39:00.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:76:0)
[14:39:00.730] Timer tick, asking Buildbucket for the build status
[14:39:00.821] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:00.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:77:0) after 1m0s
[14:40:01.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:77:0)
[14:40:01.609] Timer tick, asking Buildbucket for the build status
[14:40:01.693] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:01.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:78:0) after 1m0s
[14:41:01.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:78:0)
[14:41:01.708] Timer tick, asking Buildbucket for the build status
[14:41:01.809] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:01.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:79:0) after 1m0s
[14:42:02.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:79:0)
[14:42:02.226] Timer tick, asking Buildbucket for the build status
[14:42:02.353] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:02.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:80:0) after 1m0s
[14:43:02.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:80:0)
[14:43:02.409] Timer tick, asking Buildbucket for the build status
[14:43:02.549] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:02.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:81:0) after 1m0s
[14:44:02.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:81:0)
[14:44:02.577] Timer tick, asking Buildbucket for the build status
[14:44:02.659] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:02.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:82:0) after 1m0s
[14:45:02.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:82:0)
[14:45:02.669] Timer tick, asking Buildbucket for the build status
[14:45:02.745] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:02.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:83:0) after 1m0s
[14:46:02.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:83:0)
[14:46:02.971] Timer tick, asking Buildbucket for the build status
[14:46:03.168] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:03.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:84:0) after 1m0s
[14:47:03.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:84:0)
[14:47:03.201] Timer tick, asking Buildbucket for the build status
[14:47:03.490] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:03.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:85:0) after 1m0s
[14:48:03.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:85:0)
[14:48:03.585] Timer tick, asking Buildbucket for the build status
[14:48:03.830] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:03.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:86:0) after 1m0s
[14:49:03.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:86:0)
[14:49:03.865] Timer tick, asking Buildbucket for the build status
[14:49:03.938] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:03.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:87:0) after 1m0s
[14:50:04.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:87:0)
[14:50:04.119] Timer tick, asking Buildbucket for the build status
[14:50:04.347] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:04.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:88:0) after 1m0s
[14:51:04.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:88:0)
[14:51:04.569] Timer tick, asking Buildbucket for the build status
[14:51:04.663] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:04.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:89:0) after 1m0s
[14:52:05.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:89:0)
[14:52:05.021] Timer tick, asking Buildbucket for the build status
[14:52:05.101] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:05.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:90:0) after 1m0s
[14:53:05.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:90:0)
[14:53:05.447] Timer tick, asking Buildbucket for the build status
[14:53:05.767] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:05.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:91:0) after 1m0s
[14:54:06.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:91:0)
[14:54:06.060] Timer tick, asking Buildbucket for the build status
[14:54:06.219] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:06.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:92:0) after 1m0s
[14:55:06.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:92:0)
[14:55:06.279] Timer tick, asking Buildbucket for the build status
[14:55:06.418] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:06.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:93:0) after 1m0s
[14:56:06.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:93:0)
[14:56:06.425] Timer tick, asking Buildbucket for the build status
[14:56:06.517] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:06.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:94:0) after 1m0s
[14:57:06.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:94:0)
[14:57:06.626] Timer tick, asking Buildbucket for the build status
[14:57:06.722] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:06.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:95:0) after 1m0s
[14:58:06.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:95:0)
[14:58:06.737] Timer tick, asking Buildbucket for the build status
[14:58:06.850] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:06.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:96:0) after 1m0s
[14:59:06.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:96:0)
[14:59:06.929] Timer tick, asking Buildbucket for the build status
[14:59:07.048] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:07.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:97:0) after 1m0s
[15:00:07.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:97:0)
[15:00:07.072] Timer tick, asking Buildbucket for the build status
[15:00:07.544] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:07.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:98:0) after 1m0s
[15:01:07.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:98:0)
[15:01:07.567] Timer tick, asking Buildbucket for the build status
[15:01:07.697] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:07.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:99:0) after 1m0s
[15:02:07.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:99:0)
[15:02:07.755] Timer tick, asking Buildbucket for the build status
[15:02:09.015] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:09.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:100:0) after 1m0s
[15:03:09.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:100:0)
[15:03:09.124] Timer tick, asking Buildbucket for the build status
[15:03:09.206] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:09.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:101:0) after 1m0s
[15:04:09.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:101:0)
[15:04:09.236] Timer tick, asking Buildbucket for the build status
[15:04:09.365] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:09.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:102:0) after 1m0s
[15:05:09.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:102:0)
[15:05:09.432] Timer tick, asking Buildbucket for the build status
[15:05:09.507] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:09.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:103:0) after 1m0s
[15:06:09.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:103:0)
[15:06:09.531] Timer tick, asking Buildbucket for the build status
[15:06:09.744] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:09.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:104:0) after 1m0s
[15:07:09.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:104:0)
[15:07:09.867] Timer tick, asking Buildbucket for the build status
[15:07:09.974] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:09.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:105:0) after 1m0s
[15:08:10.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:105:0)
[15:08:10.025] Timer tick, asking Buildbucket for the build status
[15:08:10.112] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:10.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:106:0) after 1m0s
[15:09:10.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:106:0)
[15:09:10.129] Timer tick, asking Buildbucket for the build status
[15:09:10.429] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:10.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:107:0) after 1m0s
[15:10:10.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:107:0)
[15:10:10.453] Timer tick, asking Buildbucket for the build status
[15:10:11.026] Build 8853232811369619072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:11.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018662873442495312:108:0) after 1m0s
[15:10:38.281] Received PubSub notification, asking Buildbucket for the build status
[15:10:38.342] Build 8853232811369619072: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:10:38.342] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615302637931551",
"created_by": "project:chromium",
"created_ts": "1615296272839988",
"failure_reason": "BUILD_FAILURE",
"id": "8853232811369619072",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b8b4d6fd4b19e704bceda653c0379c94bda9c50\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**app_list_unittests** failed because of:\\n\\n- All/AppsGridViewTest.MouseDragFlipPage/1\\n\\n- All/AppsGridViewTest.MouseDragFlipPage/0\"}, \"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\": \"9b8b4d6fd4b19e704bceda653c0379c94bda9c50\", \"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-201-1nl3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22922, \"got_angle_revision\": \"faa3915ee3f06dade41a2bc260d850b99c5c6845\", \"got_dawn_revision\": \"7c3b5740db6be782ca4d2e78139568b67db1fc0f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"9b8b4d6fd4b19e704bceda653c0379c94bda9c50\", \"got_revision_cp\": \"refs/heads/master@{#861129}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"5c86b9ed5fdab5a53c326ae37b77effcef0b67ff\", \"got_v8_revision_cp\": \"refs/heads/9.1.75@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"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\": \"9b8b4d6fd4b19e704bceda653c0379c94bda9c50\", \"swarm_hashes_refs/heads/master(at){#861129}_without_patch\": {\"absl_hardening_tests\": \"8e49e46e0d87d87fbb6ce0fd9b5a6acec830200f\", \"accessibility_unittests\": \"5489650d176f06620697085f61a032e056f08501\", \"angle_unittests\": \"d4a7976e4a6a492558001fdbc77080f39083c36b\", \"app_list_unittests\": \"d9b52218ecfad7289371b3b9ed6077619cdd806e\", \"app_shell_unittests\": \"195a489ce0dfb71c4e4c7d0b99e70e2cc26a04c1\", \"ash_unittests\": \"5368db90161b91d82362d9e0561d3cca27cba38b\", \"aura_unittests\": \"8bb6f66f70172c920e1ee338502a30c2f3b0a5f4\", \"base_unittests\": \"ea007ee9ae8f96f9ddac64e477a445714c6dc6c8\", \"base_util_unittests\": \"b15d2e089b40c3de34abd26006324adaa71abee3\", \"blink_common_unittests\": \"b7a0f7f6e88129d464d503349c192d1d9720b9d3\", \"blink_fuzzer_unittests\": \"a1fb99f82ce641955e10d793d5fe434b82eb45a1\", \"blink_heap_unittests\": \"6afada5472610a2cc21a1846ac0149977cda19d9\", \"blink_platform_unittests\": \"a0644e1d42217df8bafb6df987b932fc1148dfd7\", \"blink_unittests\": \"cdd8801b5a0f9c35cfce8d9d6a4669d9213eb0db\", \"boringssl_crypto_tests\": \"f41c5674d5b1565b976cf77b97c7e74f4a371f07\", \"boringssl_ssl_tests\": \"b518193c5d89281bd16f4adc59d7406fd8218aa9\", \"browser_tests\": \"04f8126b35725a2b68f4db01d0a4dd4999469116\", \"capture_unittests\": \"36eb4402f33e56b5cf94c0e365d4ffef09473ee1\", \"cast_unittests\": \"29e4a218ad5a3917d2ea4c6846b7e82b4d49f785\", \"cc_unittests\": \"2afee8cb196039f8f135c42d94bab0737b695f9f\", \"chrome_app_unittests\": \"40bee66bcf3561c01dd56fa342ce6efc230cd3b8\", \"chromedriver_unittests\": \"94aa30df9a5a202443aa589d9903208d84a35f98\", \"chromeos_components_unittests\": \"47d0696b1755add90699012cfa454f98415cc382\", \"chromeos_unittests\": \"a42d950ba90436d26aab8d3cb29e3ffb5edf34f7\", \"color_unittests\": \"6c7c2f7814dce81f2ed5be10465c873db27d2b3f\", \"components_browsertests\": \"b458c7b455f7bf877985e71cdb4e2644f7ae231f\", \"components_unittests\": \"58a6918ed9dc6d35ff70c1e3248dee209bb81cf1\", \"compositor_unittests\": \"8cde3bc2f1a78aa64496ef04fc81ce310f291bce\", \"content_browsertests\": \"feb1c98659c2aaf164e5b9f824cd200fd74d5c12\", \"content_unittests\": \"57d481558553325835cb810ecaf4f4d5a0f186fc\", \"crashpad_tests\": \"69bdb0ce72eaf42127984bc6899590f2ec15064c\", \"crypto_unittests\": \"a5b4893e6970fc0825b218e8c4c34072812c2caf\", \"dbus_unittests\": \"a0451f155a46e8d624606a62e073fe9b2c10fb0a\", \"device_unittests\": \"b6f57a6759e492ec1c5dd8377048b6be1b942cfa\", \"display_unittests\": \"e5c33a71d4e1db9985fad565eb359327ca1a5ef8\", \"events_unittests\": \"ce8510a9c82f32818bb6a798500a907e6189e9fa\", \"exo_unittests\": \"1c0f674fbd374d1c9a0376e504d88f2751fcf06f\", \"extensions_browsertests\": \"7dc7289aa2e5c1e2aa236c18c713a8e89561cb8b\", \"extensions_unittests\": \"c224aa5c3573ab2f103bbdf50c19b8019a5d4003\", \"filesystem_service_unittests\": \"721f1d312f4f389cb77a005ab5696720c045d841\", \"gcm_unit_tests\": \"1a20e19ca269b73986b57b5e9ba148ec5b5231df\", \"gfx_unittests\": \"ed232b0adca145db2f7525860b12be4897b15d45\", \"gin_unittests\": \"802b16a6743627888b1ec0e291ad09969ff1ae03\", \"gl_unittests_ozone\": \"a789cdbafe4ceb280364a75d1bb83fc5cd614bd4\", \"google_apis_unittests\": \"96d10c0bde82acd0bc019a717da5f91924b74f33\", \"gpu_unittests\": \"d58fc075dce4bfea393c090a5d882fa14e887ab6\", \"gwp_asan_unittests\": \"934869668cad20b6ffae3bfd8acbaf8757ff8052\", \"interactive_ui_tests\": \"a9f230bd6aaa7a36647ff57c38ad745546bd391a\", \"ipc_tests\": \"c04e2438631173388cbc5d5a033fa06e5721eba3\", \"jingle_unittests\": \"b97a7c0d777dd1bdd135d6d3686c097474c9350f\", \"keyboard_unittests\": \"dc5e1954ccc524d495e6300e3c6a42d1f3508b79\", \"latency_unittests\": \"fc30b2e859aa066939b1def92ac804e332f73be2\", \"libjingle_xmpp_unittests\": \"cd5c4e496aaa57f4100ebed23505e03beada577b\", \"liburlpattern_unittests\": \"33229578f994deff0f59ff1b136860a43f447572\", \"media_blink_unittests\": \"1f32fc6470757f6eab51f52ac4bd5556bbf9c813\", \"media_unittests\": \"098234221154fd9ace583e06b02bccadffff1163\", \"message_center_unittests\": \"edf28644078192327c49bd117aaffe7efbfc8a10\", \"midi_unittests\": \"ab8bcee89383faa93efc48e8197512918ef58eaa\", \"mojo_core_unittests\": \"f90981d2d176b73a9b89f5bea5e6c0be75831f49\", \"mojo_unittests\": \"1f7214b05c6d77c22bb19ffe368d29d14f05617a\", \"nacl_helper_nonsfi_unittests\": \"ef661455643d53d855339c5306f951e095d79919\", \"nacl_loader_unittests\": \"783235043a6b14d83c4788000b8977ee7dd09412\", \"native_theme_unittests\": \"33fe00e923212c2fa05e9b7f6cf69bee1da70e97\", \"net_unittests\": \"c3c7c33481eff6a108d6f5cd9901603441e64282\", \"ozone_gl_unittests\": \"323dc771ee2282ac497ad9cc6373a0cbb4b881b5\", \"ozone_unittests\": \"1e712bc1f50a505b78d3418bfc479b03ef02df9c\", \"ozone_x11_unittests\": \"5778d04013565b7f009f23148261644810f46597\", \"pdf_unittests\": \"3d08fcbe5753bcfb49c654e4d32b13afbcb45d01\", \"perfetto_unittests\": \"b81bfbf184b758956777d6ba0c0a27275cb78524\", \"ppapi_unittests\": \"bcbc53abc1d8e8ecdaf26f041d34ec04e3ab34c0\", \"printing_unittests\": \"83346b882b536b4d5a5170036cc08ac55fa2ced3\", \"remoting_unittests\": \"62fd9bfa8c6eddb0bc5fd2ef5b8875f6cbae22d5\", \"sandbox_linux_unittests\": \"21b06c9c7b08cea911c1bf30e9c607c30870ddc5\", \"service_manager_unittests\": \"61a162d29603df89973050e600dca8f88869f6bc\", \"services_unittests\": \"2b76d13652c50e1209d71866157cccec9597f829\", \"shell_dialogs_unittests\": \"7e1480eb8a1bf8b6dc2f2a84aa75c0942ab881e3\", \"shell_encryption_unittests\": \"0b8fa6a1bb792ffa32660e1836de58a9beee6db4\", \"skia_unittests\": \"fab0e5dea0df513212ad43f56729b02f50c95ff4\", \"snapshot_unittests\": \"becc5462fd34f2793727fba2f97d6e9964577610\", \"sql_unittests\": \"479e77157ff86ec988d194b749894c05ae50e28d\", \"storage_unittests\": \"2c8173c1986a588fd2264c821d2711333fc30bd4\", \"sync_integration_tests\": \"535697ff516ccfa4565e24e7b7395f5e4dd1c532\", \"traffic_annotation_auditor_unittests\": \"2fc04a9cd51c06354038876399f6ecc0c517ec3b\", \"ui_base_unittests\": \"724a98740fbce63e086bcba35283566c8e83ae36\", \"ui_chromeos_unittests\": \"22bcb4c840387f5fbff9836a860745d2c0ed659c\", \"ui_touch_selection_unittests\": \"8ee8d7a123eb6c0ccdc64423938afa9235dba1f7\", \"unit_tests\": \"46016d7c05bdfe6b2f68c9c99b105c4e7eec2954\", \"url_unittests\": \"5849954e6f23a7a4c3d52ce47e26e8c6767bb5fc\", \"usage_time_limit_unittests\": \"039c872461e691d8dbd0db1530a9a8fdb507afd3\", \"views_unittests\": \"f5197bb12e5a3da110fb08afb71ff075ee5d1509\", \"viz_unittests\": \"826074a11a7bf43736e2b4f719fe2594ccb4ab9e\", \"wayland_client_tests\": \"4c908d68fd4584d2adee54e81d86030c913e2bf9\", \"wm_unittests\": \"3a6f85ad5d5b5af3a830c9b512e943186206a2f3\", \"wtf_unittests\": \"26c7ee11a4bb573bd4869905dd0f20945eb46649\", \"zlib_unittests\": \"ef8b0de5cd2fda95af4bf6456b36efe722a7acbe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_349e20fa0346c22afd9d85eafc166958d65f8d3eb174d2113a3f89c2e822dead_v2\", \"builder_3ee79eab7726d87d4f9bf92f4b58b9506b0a7a0d17f466f0c3d67bd50a4697d1_v2\", \"builder_4637b11d2a56187e25d14badb4fa154a12143e816e25cb34f5fe38c5c81ebb47_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-201-1nl3\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**app_list_unittests** failed because of:\\n\\n- All/AppsGridViewTest.MouseDragFlipPage/1\\n\\n- All/AppsGridViewTest.MouseDragFlipPage/0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615296285419312",
"status": "COMPLETED",
"status_changed_ts": "1615296288942881",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22922",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9b8b4d6fd4b19e704bceda653c0379c94bda9c50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b8b4d6fd4b19e704bceda653c0379c94bda9c50",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018662873442495312",
"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/8853232811369619072/+/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:522ffacf8caefd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615302637932163",
"url": "https://ci.chromium.org/b/8853232811369619072",
"utcnow_ts": "1615302638334904"
}
}
[15:10:38.342] Invocation finished in 1h46m6.863223537s with status FAILED