[11:11:40.297] New invocation is queued and will start shortly
[11:11:41.370] Starting the invocation (attempt 1)
[11:11:41.428] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:11:41.428] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:11:41.428] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9083266868912130032",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f9355806e1184c010f161268d86641db2e052fb9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9083266868912130032",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/f9355806e1184c010f161268d86641db2e052fb9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9355806e1184c010f161268d86641db2e052fb9",
"gitiles_ref:refs/heads/master"
]
}
[11:11:42.334] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1553685101768514",
"id": "8917836806686798608",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f9355806e1184c010f161268d86641db2e052fb9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553685102229450",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11567",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f9355806e1184c010f161268d86641db2e052fb9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9355806e1184c010f161268d86641db2e052fb9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083266868912130032",
"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/8917836806686798608/+/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": "1553685102229562",
"url": "https://ci.chromium.org/b/8917836806686798608",
"utcnow_ts": "1553685102326465"
}
}
[11:11:42.334] Task URL: https://ci.chromium.org/b/8917836806686798608
[11:11:42.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:2:0) after 1m0s
[11:12:42.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:2:0)
[11:12:42.351] Timer tick, asking Buildbucket for the build status
[11:12:42.499] Build 8917836806686798608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:12:42.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:3:0) after 1m0s
[11:13:42.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:3:0)
[11:13:42.514] Timer tick, asking Buildbucket for the build status
[11:13:42.629] Build 8917836806686798608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:13:42.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:4:0) after 1m0s
[11:14:42.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:4:0)
[11:14:42.608] Timer tick, asking Buildbucket for the build status
[11:14:43.517] Build 8917836806686798608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:14:43.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:5:0) after 1m0s
[11:15:43.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:5:0)
[11:15:43.515] Timer tick, asking Buildbucket for the build status
[11:15:43.761] Build 8917836806686798608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:15:43.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:6:0) after 1m0s
[11:16:43.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:6:0)
[11:16:43.787] Timer tick, asking Buildbucket for the build status
[11:16:44.005] Build 8917836806686798608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:16:44.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:7:0) after 1m0s
[11:17:44.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:7:0)
[11:17:44.023] Timer tick, asking Buildbucket for the build status
[11:17:44.412] Build 8917836806686798608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:17:44.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:8:0) after 1m0s
[11:18:25.673] Received PubSub notification, asking Buildbucket for the build status
[11:18:25.785] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:44.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:8:0)
[11:18:44.398] Timer tick, asking Buildbucket for the build status
[11:18:44.678] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:44.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:10:0) after 1m0s
[11:19:44.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:10:0)
[11:19:44.694] Timer tick, asking Buildbucket for the build status
[11:19:44.823] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:44.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:11:0) after 1m0s
[11:20:44.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:11:0)
[11:20:44.845] Timer tick, asking Buildbucket for the build status
[11:20:45.064] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:45.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:12:0) after 1m0s
[11:21:45.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:12:0)
[11:21:45.036] Timer tick, asking Buildbucket for the build status
[11:21:45.284] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:45.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:13:0) after 1m0s
[11:22:45.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:13:0)
[11:22:45.290] Timer tick, asking Buildbucket for the build status
[11:22:45.538] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:45.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:14:0) after 1m0s
[11:23:45.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:14:0)
[11:23:45.557] Timer tick, asking Buildbucket for the build status
[11:23:45.706] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:45.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:15:0) after 1m0s
[11:24:45.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:15:0)
[11:24:45.691] Timer tick, asking Buildbucket for the build status
[11:24:45.811] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:45.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:16:0) after 1m0s
[11:25:45.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:16:0)
[11:25:45.819] Timer tick, asking Buildbucket for the build status
[11:25:46.223] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:46.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:17:0) after 1m0s
[11:26:46.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:17:0)
[11:26:46.241] Timer tick, asking Buildbucket for the build status
[11:26:46.471] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:46.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:18:0) after 1m0s
[11:27:46.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:18:0)
[11:27:46.515] Timer tick, asking Buildbucket for the build status
[11:27:46.661] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:46.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:19:0) after 1m0s
[11:28:46.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:19:0)
[11:28:46.683] Timer tick, asking Buildbucket for the build status
[11:28:46.807] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:46.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:20:0) after 1m0s
[11:29:46.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:20:0)
[11:29:46.837] Timer tick, asking Buildbucket for the build status
[11:29:46.918] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:46.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:21:0) after 1m0s
[11:30:46.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:21:0)
[11:30:46.946] Timer tick, asking Buildbucket for the build status
[11:30:47.862] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:47.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:22:0) after 1m0s
[11:31:47.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:22:0)
[11:31:47.880] Timer tick, asking Buildbucket for the build status
[11:31:48.103] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:48.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:23:0) after 1m0s
[11:32:48.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:23:0)
[11:32:48.091] Timer tick, asking Buildbucket for the build status
[11:32:48.207] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:48.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:24:0) after 1m0s
[11:33:48.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:24:0)
[11:33:48.236] Timer tick, asking Buildbucket for the build status
[11:33:48.394] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:48.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:25:0) after 1m0s
[11:34:48.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:25:0)
[11:34:48.413] Timer tick, asking Buildbucket for the build status
[11:34:48.526] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:48.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:26:0) after 1m0s
[11:35:48.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:26:0)
[11:35:48.505] Timer tick, asking Buildbucket for the build status
[11:35:48.654] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:48.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:27:0) after 1m0s
[11:36:48.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:27:0)
[11:36:48.675] Timer tick, asking Buildbucket for the build status
[11:36:49.449] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:49.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:28:0) after 1m0s
[11:37:49.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:28:0)
[11:37:49.487] Timer tick, asking Buildbucket for the build status
[11:37:49.595] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:49.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:29:0) after 1m0s
[11:38:49.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:29:0)
[11:38:49.599] Timer tick, asking Buildbucket for the build status
[11:38:49.699] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:49.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:30:0) after 1m0s
[11:39:49.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:30:0)
[11:39:49.717] Timer tick, asking Buildbucket for the build status
[11:39:49.810] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:49.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:31:0) after 1m0s
[11:40:49.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:31:0)
[11:40:49.829] Timer tick, asking Buildbucket for the build status
[11:40:50.013] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:50.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:32:0) after 1m0s
[11:41:50.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:32:0)
[11:41:50.034] Timer tick, asking Buildbucket for the build status
[11:41:50.209] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:50.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:33:0) after 1m0s
[11:42:50.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:33:0)
[11:42:50.230] Timer tick, asking Buildbucket for the build status
[11:42:50.399] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:50.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:34:0) after 1m0s
[11:43:50.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:34:0)
[11:43:50.422] Timer tick, asking Buildbucket for the build status
[11:43:50.548] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:50.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:35:0) after 1m0s
[11:44:50.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:35:0)
[11:44:50.589] Timer tick, asking Buildbucket for the build status
[11:44:50.720] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:50.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:36:0) after 1m0s
[11:45:50.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:36:0)
[11:45:50.739] Timer tick, asking Buildbucket for the build status
[11:45:50.840] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:50.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:37:0) after 1m0s
[11:46:50.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:37:0)
[11:46:50.845] Timer tick, asking Buildbucket for the build status
[11:46:50.994] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:50.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:38:0) after 1m0s
[11:47:51.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:38:0)
[11:47:51.014] Timer tick, asking Buildbucket for the build status
[11:47:51.159] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:51.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:39:0) after 1m0s
[11:48:51.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:39:0)
[11:48:51.180] Timer tick, asking Buildbucket for the build status
[11:48:51.376] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:51.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:40:0) after 1m0s
[11:49:51.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:40:0)
[11:49:51.366] Timer tick, asking Buildbucket for the build status
[11:49:51.614] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:51.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:41:0) after 1m0s
[11:50:51.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:41:0)
[11:50:51.674] Timer tick, asking Buildbucket for the build status
[11:50:53.599] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:53.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:42:0) after 1m0s
[11:51:53.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:42:0)
[11:51:53.618] Timer tick, asking Buildbucket for the build status
[11:51:54.009] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:54.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:43:0) after 1m0s
[11:52:54.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:43:0)
[11:52:54.035] Timer tick, asking Buildbucket for the build status
[11:52:54.199] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:54.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:44:0) after 1m0s
[11:53:54.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:44:0)
[11:53:54.190] Timer tick, asking Buildbucket for the build status
[11:53:54.440] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:54.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:45:0) after 1m0s
[11:54:54.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:45:0)
[11:54:54.462] Timer tick, asking Buildbucket for the build status
[11:54:54.896] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:54.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:46:0) after 1m0s
[11:55:54.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:46:0)
[11:55:54.915] Timer tick, asking Buildbucket for the build status
[11:55:55.087] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:55.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:47:0) after 1m0s
[11:56:55.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:47:0)
[11:56:55.108] Timer tick, asking Buildbucket for the build status
[11:56:55.519] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:55.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:48:0) after 1m0s
[11:57:55.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:48:0)
[11:57:55.538] Timer tick, asking Buildbucket for the build status
[11:57:55.902] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:55.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:49:0) after 1m0s
[11:58:55.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:49:0)
[11:58:55.896] Timer tick, asking Buildbucket for the build status
[11:58:56.104] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:56.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:50:0) after 1m0s
[11:59:56.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:50:0)
[11:59:56.127] Timer tick, asking Buildbucket for the build status
[11:59:56.254] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:56.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:51:0) after 1m0s
[12:00:56.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:51:0)
[12:00:56.273] Timer tick, asking Buildbucket for the build status
[12:00:57.062] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:57.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:52:0) after 1m0s
[12:01:57.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:52:0)
[12:01:57.065] Timer tick, asking Buildbucket for the build status
[12:01:57.195] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:57.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:53:0) after 1m0s
[12:02:57.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:53:0)
[12:02:57.200] Timer tick, asking Buildbucket for the build status
[12:02:57.309] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:57.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:54:0) after 1m0s
[12:03:57.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:54:0)
[12:03:57.331] Timer tick, asking Buildbucket for the build status
[12:03:57.490] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:57.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:55:0) after 1m0s
[12:04:57.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:55:0)
[12:04:57.467] Timer tick, asking Buildbucket for the build status
[12:04:57.671] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:57.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:56:0) after 1m0s
[12:05:57.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:56:0)
[12:05:57.690] Timer tick, asking Buildbucket for the build status
[12:05:57.874] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:57.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:57:0) after 1m0s
[12:06:57.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:57:0)
[12:06:57.877] Timer tick, asking Buildbucket for the build status
[12:06:58.089] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:58.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:58:0) after 1m0s
[12:07:58.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:58:0)
[12:07:58.084] Timer tick, asking Buildbucket for the build status
[12:07:58.353] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:58.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:59:0) after 1m0s
[12:08:58.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:59:0)
[12:08:58.377] Timer tick, asking Buildbucket for the build status
[12:08:58.554] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:58.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:60:0) after 1m0s
[12:09:58.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:60:0)
[12:09:58.572] Timer tick, asking Buildbucket for the build status
[12:09:58.694] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:58.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:61:0) after 1m0s
[12:10:58.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:61:0)
[12:10:58.685] Timer tick, asking Buildbucket for the build status
[12:10:58.805] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:58.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:62:0) after 1m0s
[12:11:58.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:62:0)
[12:11:58.825] Timer tick, asking Buildbucket for the build status
[12:11:59.007] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:59.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:63:0) after 1m0s
[12:12:59.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:63:0)
[12:12:59.009] Timer tick, asking Buildbucket for the build status
[12:12:59.487] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:59.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:64:0) after 1m0s
[12:13:59.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:64:0)
[12:13:59.508] Timer tick, asking Buildbucket for the build status
[12:13:59.626] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:59.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:65:0) after 1m0s
[12:14:59.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:65:0)
[12:14:59.637] Timer tick, asking Buildbucket for the build status
[12:14:59.772] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:59.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:66:0) after 1m0s
[12:15:59.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:66:0)
[12:15:59.795] Timer tick, asking Buildbucket for the build status
[12:15:59.898] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:59.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:67:0) after 1m0s
[12:16:59.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:67:0)
[12:16:59.921] Timer tick, asking Buildbucket for the build status
[12:17:00.196] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:00.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:68:0) after 1m0s
[12:18:00.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:68:0)
[12:18:00.202] Timer tick, asking Buildbucket for the build status
[12:18:00.341] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:00.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:69:0) after 1m0s
[12:19:00.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:69:0)
[12:19:00.364] Timer tick, asking Buildbucket for the build status
[12:19:00.803] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:00.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:70:0) after 1m0s
[12:20:00.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:70:0)
[12:20:00.823] Timer tick, asking Buildbucket for the build status
[12:20:00.960] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:00.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:71:0) after 1m0s
[12:21:01.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:71:0)
[12:21:01.003] Timer tick, asking Buildbucket for the build status
[12:21:01.355] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:01.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:72:0) after 1m0s
[12:22:01.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:72:0)
[12:22:01.391] Timer tick, asking Buildbucket for the build status
[12:22:01.511] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:01.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:73:0) after 1m0s
[12:23:01.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:73:0)
[12:23:01.497] Timer tick, asking Buildbucket for the build status
[12:23:02.220] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:02.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:74:0) after 1m0s
[12:24:02.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:74:0)
[12:24:02.197] Timer tick, asking Buildbucket for the build status
[12:24:02.537] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:02.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:75:0) after 1m0s
[12:25:02.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:75:0)
[12:25:02.574] Timer tick, asking Buildbucket for the build status
[12:25:02.793] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:02.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:76:0) after 1m0s
[12:26:02.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:76:0)
[12:26:02.784] Timer tick, asking Buildbucket for the build status
[12:26:03.640] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:03.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:77:0) after 1m0s
[12:27:03.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:77:0)
[12:27:03.663] Timer tick, asking Buildbucket for the build status
[12:27:04.224] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:04.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:78:0) after 1m0s
[12:28:04.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:78:0)
[12:28:04.210] Timer tick, asking Buildbucket for the build status
[12:28:04.354] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:04.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:79:0) after 1m0s
[12:29:04.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:79:0)
[12:29:04.401] Timer tick, asking Buildbucket for the build status
[12:29:04.517] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:04.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:80:0) after 1m0s
[12:30:04.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:80:0)
[12:30:04.532] Timer tick, asking Buildbucket for the build status
[12:30:04.683] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:04.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:81:0) after 1m0s
[12:31:04.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:81:0)
[12:31:04.698] Timer tick, asking Buildbucket for the build status
[12:31:06.137] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:06.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:82:0) after 1m0s
[12:32:06.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:82:0)
[12:32:06.127] Timer tick, asking Buildbucket for the build status
[12:32:06.283] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:06.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:83:0) after 1m0s
[12:33:06.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:83:0)
[12:33:06.308] Timer tick, asking Buildbucket for the build status
[12:33:06.500] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:06.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:84:0) after 1m0s
[12:34:06.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:84:0)
[12:34:06.487] Timer tick, asking Buildbucket for the build status
[12:34:06.772] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:06.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:85:0) after 1m0s
[12:35:06.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:85:0)
[12:35:06.786] Timer tick, asking Buildbucket for the build status
[12:35:06.964] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:06.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:86:0) after 1m0s
[12:36:06.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:86:0)
[12:36:06.984] Timer tick, asking Buildbucket for the build status
[12:36:07.136] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:07.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:87:0) after 1m0s
[12:37:07.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:87:0)
[12:37:07.166] Timer tick, asking Buildbucket for the build status
[12:37:07.317] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:07.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:88:0) after 1m0s
[12:38:07.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:88:0)
[12:38:07.363] Timer tick, asking Buildbucket for the build status
[12:38:07.506] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:07.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:89:0) after 1m0s
[12:39:07.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:89:0)
[12:39:07.533] Timer tick, asking Buildbucket for the build status
[12:39:07.895] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:07.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:90:0) after 1m0s
[12:40:07.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:90:0)
[12:40:07.977] Timer tick, asking Buildbucket for the build status
[12:40:08.110] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:08.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:91:0) after 1m0s
[12:41:08.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:91:0)
[12:41:08.133] Timer tick, asking Buildbucket for the build status
[12:41:08.238] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:08.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:92:0) after 1m0s
[12:42:08.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:92:0)
[12:42:08.259] Timer tick, asking Buildbucket for the build status
[12:42:08.875] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:08.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:93:0) after 1m0s
[12:43:08.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:93:0)
[12:43:08.862] Timer tick, asking Buildbucket for the build status
[12:43:08.985] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:08.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:94:0) after 1m0s
[12:44:09.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:94:0)
[12:44:09.012] Timer tick, asking Buildbucket for the build status
[12:44:09.139] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:09.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:95:0) after 1m0s
[12:45:09.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:95:0)
[12:45:09.162] Timer tick, asking Buildbucket for the build status
[12:45:09.269] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:09.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:96:0) after 1m0s
[12:46:09.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:96:0)
[12:46:09.259] Timer tick, asking Buildbucket for the build status
[12:46:09.426] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:09.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:97:0) after 1m0s
[12:47:09.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:97:0)
[12:47:09.418] Timer tick, asking Buildbucket for the build status
[12:47:09.691] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:09.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:98:0) after 1m0s
[12:48:09.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:98:0)
[12:48:09.683] Timer tick, asking Buildbucket for the build status
[12:48:10.421] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:10.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:99:0) after 1m0s
[12:49:10.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:99:0)
[12:49:10.444] Timer tick, asking Buildbucket for the build status
[12:49:10.685] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:10.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:100:0) after 1m0s
[12:50:10.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:100:0)
[12:50:10.709] Timer tick, asking Buildbucket for the build status
[12:50:10.901] Build 8917836806686798608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:10.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083266868912130032:101:0) after 1m0s
[12:50:23.284] Received PubSub notification, asking Buildbucket for the build status
[12:50:23.372] Build 8917836806686798608: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:50:23.372] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1553691020798161",
"created_by": "project:chromium",
"created_ts": "1553685101768514",
"failure_reason": "BUILD_FAILURE",
"id": "8917836806686798608",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f9355806e1184c010f161268d86641db2e052fb9\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"5 tests failed: ['browser_tests', 'non_network_service_browser_tests', 'non_single_process_mash_browser_tests', 'viz_browser_tests', 'non_network_service_interactive_ui_tests']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 11567, \"got_angle_revision\": \"518c679da10956a4c401214cf3ac304e09eb1a12\", \"got_dawn_revision\": \"5490e9aca17eb2f58633b00d823a3fc1e58f2b61\", \"got_nacl_revision\": \"de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1\", \"got_revision\": \"f9355806e1184c010f161268d86641db2e052fb9\", \"got_revision_cp\": \"refs/heads/master@{#644741}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"eec23d988ca623a09b1bc4f04c34a4cf91795eb5\", \"got_v8_revision_cp\": \"refs/heads/7.5.123@{#1}\", \"got_webrtc_revision\": \"712fb89ca86ba429ae76540c69a3617f67a504cf\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27303}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f9355806e1184c010f161268d86641db2e052fb9\", \"swarm_hashes\": {\"accessibility_unittests\": \"a0d293e5bec575eba4799590d82996dce04273d0\", \"angle_unittests\": \"b8542ebb6415f59dcc0d0c1008b0473ed9c84947\", \"app_list_unittests\": \"debfcfe61b7a4ecb4e9ff8ec7e824cddbe66b0c4\", \"app_shell_unittests\": \"f6a54e8776ef172de17a0df8928ab44a72c1397c\", \"ash_unittests\": \"a8d9c2652eaf91974fe1edaf15fb19f2fcb90185\", \"aura_unittests\": \"825c45cf87e2e63d861783a328b6e71f39e37f35\", \"base_unittests\": \"5d4474daab2abbfaf255e681f6c70d44952723d7\", \"blink_common_unittests\": \"0b24cd9c60430906c9847f8f87fe440364400905\", \"blink_fuzzer_unittests\": \"042af46569a81b93bae53d7cfacea88c348f5415\", \"blink_heap_unittests\": \"01c3fa38210236de8dd931ba888e50a07750bc36\", \"blink_platform_unittests\": \"a51280a6f695c006e83df8198b86db8bc9d5dd03\", \"blink_unittests\": \"6ca153cbddbb706ad7ced201caf4642a0b274215\", \"boringssl_crypto_tests\": \"9f2015532eef9964b797e4874d763af8f41c8b97\", \"boringssl_ssl_tests\": \"5b82a3ce0ba0e6b2edd608a2f25b89417d421953\", \"browser_tests\": \"135c4ac15eb58ba3dbd26ae8f782a8a8bd6b37cf\", \"cacheinvalidation_unittests\": \"74e665cf2e6407e37936f2ab51be01a836b9c483\", \"capture_unittests\": \"83b3d421e002420b1869c41dccec4b8b658b3784\", \"cast_unittests\": \"34ae87e0cbd373ab77d15816878d8ab8636994f0\", \"cc_unittests\": \"e0b4a19e3330c98bddbd7095bc76bf830ea13149\", \"chrome_app_unittests\": \"b12ee7b27a8b8aea0a79c3a2776cfe497c89709c\", \"chromedriver_unittests\": \"768e4dd5151c8e1ae0b2d2a037e6a2f6bbfbcbc9\", \"chromeos_components_unittests\": \"b33d88d35df601cc2dd8cc548589abd058d8bc57\", \"chromeos_unittests\": \"f646894eeb56e8cb0f7caffae2862f8c62c5c1df\", \"components_browsertests\": \"518559dfec6acb06f592e017106bd9a51fb6a591\", \"components_unittests\": \"f2e906580a2b05e46b6db79135c027fa689861ae\", \"compositor_unittests\": \"5919a19a353e1b10fe3390e4728379b539f9be2a\", \"content_browsertests\": \"acfcbd2aa7f1d52c1a947107ea5028dcdc9fd237\", \"content_unittests\": \"851cbdec7b4ac17d31dcd672312a9783948a6b5d\", \"crypto_unittests\": \"a2900790e5f87e704d2568c23971cb23d82c2995\", \"dbus_unittests\": \"fdc9e8851589fe78d842ec70bcf047c8c849e19d\", \"device_unittests\": \"266d49c1e8d294d9d3596509a9d98c9f29f0cf1f\", \"display_unittests\": \"2c14bcf5f69a58c51ab7a0ffecc113c7961dc078\", \"events_unittests\": \"657b3f395a9c193c141f65c2839d243825565645\", \"exo_unittests\": \"fee0cc69987bd9d98af1aa075ebfbeb16baf0b02\", \"extensions_browsertests\": \"2264ba55dc610e9d1638f287a529065510e114c1\", \"extensions_unittests\": \"5a490f1a7efe95fb21414f35694783e172f77a4d\", \"filesystem_service_unittests\": \"1819bb89a9a8e903a8479431558ce7af8fe361b5\", \"gcm_unit_tests\": \"097091067517a7f371d5a6008d6735663cc4ca5c\", \"gfx_unittests\": \"efca141fcde83f66226284cfed1413842d122acd\", \"gin_unittests\": \"7e7a556ff8d5a051fb12bbd2aa27b73294946898\", \"gl_unittests_ozone\": \"ab3c055bd3745a55387e29099f711a1d75d82657\", \"google_apis_unittests\": \"c8c4152c2db7bb1fe68725137b33ce659d465f5c\", \"gpu_unittests\": \"c8bb40e6774063cec1b008796f23ff5343ac308e\", \"interactive_ui_tests\": \"de227f406e0047cc48cff1b819092e49373dab04\", \"ipc_tests\": \"fddd643f4ae926ca90576e95731e51a2d0cc8fca\", \"jingle_unittests\": \"718fbedf7a97626f399d9d05afc392563f1130e0\", \"keyboard_unittests\": \"9f6ba2609f79ddf8479ec55690c4d4d030e19887\", \"latency_unittests\": \"bfd558b053963599624d5279a1cb3bf614ba8400\", \"leveldb_service_unittests\": \"75e33331013a6216af88554e93b422306da5535d\", \"libjingle_xmpp_unittests\": \"223ae894c995314e98b38799181216dfd366e603\", \"media_blink_unittests\": \"0819d82bd00d12e27263d4ebce74614eccd0acf5\", \"media_service_unittests\": \"52c3cb852c13dbabf4d014582ea3e09d046d8663\", \"media_unittests\": \"dfd49336033e14871c87b3f1e7ab3ff94cf078af\", \"message_center_unittests\": \"42f7d3baa136c8dcaa2ccf72d277d136fec921ae\", \"midi_unittests\": \"99e2018900a1c88163267f508634b99566b2d1b6\", \"mojo_core_unittests\": \"0fb8df3773beae9ddba6ed5eaae614c0b0a581e6\", \"mojo_unittests\": \"326cf038405637e93de3a6e69095150a73e20599\", \"nacl_helper_nonsfi_unittests\": \"ccac506ef4c968342ccee65eefb5b5ce8f65b5be\", \"nacl_loader_unittests\": \"5d223661dd03d51945152be854450c120686a5a9\", \"native_theme_unittests\": \"8149a16aa98f98feb2ed7605179b260144807d68\", \"net_unittests\": \"300bb3793bea2e723f98eb52a7747890a4fca0bd\", \"ozone_gl_unittests\": \"73845d88abba0ccc0fa6913c22832686bd8b1f22\", \"ozone_unittests\": \"3a5f5e125e8345dd8d1c77673d7a99adb137ca13\", \"ozone_x11_unittests\": \"72046e49f0aaa15d9c6f12529d7823e3a89c2e1f\", \"pdf_unittests\": \"04fb6efa9b5e326c27a4a7c6b938d0cd7c18843d\", \"perfetto_unittests\": \"f062face83bce042010bdc3b6e6bef2b390b4d66\", \"ppapi_unittests\": \"8e3aee0f4730cdd85561285e6c09e3f9c6a6c931\", \"printing_unittests\": \"19c94295d83373518835a7aa20ff9f282c6851d6\", \"remoting_unittests\": \"1866ada4d773d7b763c0ce7a622dc6c12886c0b8\", \"sandbox_linux_unittests\": \"ce568ed46e3b2ffb2db6752a136bdef4f8b5a4e9\", \"service_manager_unittests\": \"106257dc84c46856fbebf63a58bb75e121383723\", \"services_unittests\": \"88e9a9c0346b26135221851083d0eb5395709b79\", \"shell_dialogs_unittests\": \"84cb151f3d27a38cdc29a77042bb77b843149b22\", \"skia_unittests\": \"69a37e8489d84aa0d4bea7d25c2d2d1c69962d70\", \"snapshot_unittests\": \"bc973237a28af7a73611f478ba97a5c27e8ee21f\", \"sql_unittests\": \"e9356550dff72cda3744eb62e6a5cd24162a1f90\", \"storage_unittests\": \"7e542b748b1f406f6dd17e5e7f90822b85f07ab7\", \"sync_integration_tests\": \"15afb3ed445a2377df978cbb9949e8585cfff23e\", \"traffic_annotation_auditor_unittests\": \"b40434245e6042e6468c76a418f743f0e7dd919a\", \"ui_base_unittests\": \"d88c45065772b4376ebab29f1b19be86da84d7fa\", \"ui_chromeos_unittests\": \"338ddd2100d89d2d006b1dc1de513ba4fb9da75a\", \"ui_touch_selection_unittests\": \"859c6bf721500dacf31cbae7f1ebae160652b5ac\", \"unit_tests\": \"8e23deda504e841f47b07fbef9b531de51efa6f1\", \"url_unittests\": \"e42def75b7c410174b4679d97c9b29f7008eb508\", \"usage_time_limit_unittests\": \"e176387b1aa542296aaa87455d86c663c01d8599\", \"views_unittests\": \"7d244a8f09fac8751d20cbb2b85d4352c740a25b\", \"viz_unittests\": \"a3da99223bb108017e0ca7f9c739ad91b9dbf99f\", \"wm_unittests\": \"8f11c4cf7c1fefccad6085db636dd2570f7b39d8\", \"wtf_unittests\": \"74b2af4894ae120a0c58dd0baf961c26d36c4d54\"}, \"swarm_hashes_refs/heads/master(at){#644741}_without_patch\": {\"accessibility_unittests\": \"a0d293e5bec575eba4799590d82996dce04273d0\", \"angle_unittests\": \"b8542ebb6415f59dcc0d0c1008b0473ed9c84947\", \"app_list_unittests\": \"debfcfe61b7a4ecb4e9ff8ec7e824cddbe66b0c4\", \"app_shell_unittests\": \"f6a54e8776ef172de17a0df8928ab44a72c1397c\", \"ash_unittests\": \"a8d9c2652eaf91974fe1edaf15fb19f2fcb90185\", \"aura_unittests\": \"825c45cf87e2e63d861783a328b6e71f39e37f35\", \"base_unittests\": \"5d4474daab2abbfaf255e681f6c70d44952723d7\", \"blink_common_unittests\": \"0b24cd9c60430906c9847f8f87fe440364400905\", \"blink_fuzzer_unittests\": \"042af46569a81b93bae53d7cfacea88c348f5415\", \"blink_heap_unittests\": \"01c3fa38210236de8dd931ba888e50a07750bc36\", \"blink_platform_unittests\": \"a51280a6f695c006e83df8198b86db8bc9d5dd03\", \"blink_unittests\": \"6ca153cbddbb706ad7ced201caf4642a0b274215\", \"boringssl_crypto_tests\": \"9f2015532eef9964b797e4874d763af8f41c8b97\", \"boringssl_ssl_tests\": \"5b82a3ce0ba0e6b2edd608a2f25b89417d421953\", \"browser_tests\": \"135c4ac15eb58ba3dbd26ae8f782a8a8bd6b37cf\", \"cacheinvalidation_unittests\": \"74e665cf2e6407e37936f2ab51be01a836b9c483\", \"capture_unittests\": \"83b3d421e002420b1869c41dccec4b8b658b3784\", \"cast_unittests\": \"34ae87e0cbd373ab77d15816878d8ab8636994f0\", \"cc_unittests\": \"e0b4a19e3330c98bddbd7095bc76bf830ea13149\", \"chrome_app_unittests\": \"b12ee7b27a8b8aea0a79c3a2776cfe497c89709c\", \"chromedriver_unittests\": \"768e4dd5151c8e1ae0b2d2a037e6a2f6bbfbcbc9\", \"chromeos_components_unittests\": \"b33d88d35df601cc2dd8cc548589abd058d8bc57\", \"chromeos_unittests\": \"f646894eeb56e8cb0f7caffae2862f8c62c5c1df\", \"components_browsertests\": \"518559dfec6acb06f592e017106bd9a51fb6a591\", \"components_unittests\": \"f2e906580a2b05e46b6db79135c027fa689861ae\", \"compositor_unittests\": \"5919a19a353e1b10fe3390e4728379b539f9be2a\", \"content_browsertests\": \"acfcbd2aa7f1d52c1a947107ea5028dcdc9fd237\", \"content_unittests\": \"851cbdec7b4ac17d31dcd672312a9783948a6b5d\", \"crypto_unittests\": \"a2900790e5f87e704d2568c23971cb23d82c2995\", \"dbus_unittests\": \"fdc9e8851589fe78d842ec70bcf047c8c849e19d\", \"device_unittests\": \"266d49c1e8d294d9d3596509a9d98c9f29f0cf1f\", \"display_unittests\": \"2c14bcf5f69a58c51ab7a0ffecc113c7961dc078\", \"events_unittests\": \"657b3f395a9c193c141f65c2839d243825565645\", \"exo_unittests\": \"fee0cc69987bd9d98af1aa075ebfbeb16baf0b02\", \"extensions_browsertests\": \"2264ba55dc610e9d1638f287a529065510e114c1\", \"extensions_unittests\": \"5a490f1a7efe95fb21414f35694783e172f77a4d\", \"filesystem_service_unittests\": \"1819bb89a9a8e903a8479431558ce7af8fe361b5\", \"gcm_unit_tests\": \"097091067517a7f371d5a6008d6735663cc4ca5c\", \"gfx_unittests\": \"efca141fcde83f66226284cfed1413842d122acd\", \"gin_unittests\": \"7e7a556ff8d5a051fb12bbd2aa27b73294946898\", \"gl_unittests_ozone\": \"ab3c055bd3745a55387e29099f711a1d75d82657\", \"google_apis_unittests\": \"c8c4152c2db7bb1fe68725137b33ce659d465f5c\", \"gpu_unittests\": \"c8bb40e6774063cec1b008796f23ff5343ac308e\", \"interactive_ui_tests\": \"de227f406e0047cc48cff1b819092e49373dab04\", \"ipc_tests\": \"fddd643f4ae926ca90576e95731e51a2d0cc8fca\", \"jingle_unittests\": \"718fbedf7a97626f399d9d05afc392563f1130e0\", \"keyboard_unittests\": \"9f6ba2609f79ddf8479ec55690c4d4d030e19887\", \"latency_unittests\": \"bfd558b053963599624d5279a1cb3bf614ba8400\", \"leveldb_service_unittests\": \"75e33331013a6216af88554e93b422306da5535d\", \"libjingle_xmpp_unittests\": \"223ae894c995314e98b38799181216dfd366e603\", \"media_blink_unittests\": \"0819d82bd00d12e27263d4ebce74614eccd0acf5\", \"media_service_unittests\": \"52c3cb852c13dbabf4d014582ea3e09d046d8663\", \"media_unittests\": \"dfd49336033e14871c87b3f1e7ab3ff94cf078af\", \"message_center_unittests\": \"42f7d3baa136c8dcaa2ccf72d277d136fec921ae\", \"midi_unittests\": \"99e2018900a1c88163267f508634b99566b2d1b6\", \"mojo_core_unittests\": \"0fb8df3773beae9ddba6ed5eaae614c0b0a581e6\", \"mojo_unittests\": \"326cf038405637e93de3a6e69095150a73e20599\", \"nacl_helper_nonsfi_unittests\": \"ccac506ef4c968342ccee65eefb5b5ce8f65b5be\", \"nacl_loader_unittests\": \"5d223661dd03d51945152be854450c120686a5a9\", \"native_theme_unittests\": \"8149a16aa98f98feb2ed7605179b260144807d68\", \"net_unittests\": \"300bb3793bea2e723f98eb52a7747890a4fca0bd\", \"ozone_gl_unittests\": \"73845d88abba0ccc0fa6913c22832686bd8b1f22\", \"ozone_unittests\": \"3a5f5e125e8345dd8d1c77673d7a99adb137ca13\", \"ozone_x11_unittests\": \"72046e49f0aaa15d9c6f12529d7823e3a89c2e1f\", \"pdf_unittests\": \"04fb6efa9b5e326c27a4a7c6b938d0cd7c18843d\", \"perfetto_unittests\": \"f062face83bce042010bdc3b6e6bef2b390b4d66\", \"ppapi_unittests\": \"8e3aee0f4730cdd85561285e6c09e3f9c6a6c931\", \"printing_unittests\": \"19c94295d83373518835a7aa20ff9f282c6851d6\", \"remoting_unittests\": \"1866ada4d773d7b763c0ce7a622dc6c12886c0b8\", \"sandbox_linux_unittests\": \"ce568ed46e3b2ffb2db6752a136bdef4f8b5a4e9\", \"service_manager_unittests\": \"106257dc84c46856fbebf63a58bb75e121383723\", \"services_unittests\": \"88e9a9c0346b26135221851083d0eb5395709b79\", \"shell_dialogs_unittests\": \"84cb151f3d27a38cdc29a77042bb77b843149b22\", \"skia_unittests\": \"69a37e8489d84aa0d4bea7d25c2d2d1c69962d70\", \"snapshot_unittests\": \"bc973237a28af7a73611f478ba97a5c27e8ee21f\", \"sql_unittests\": \"e9356550dff72cda3744eb62e6a5cd24162a1f90\", \"storage_unittests\": \"7e542b748b1f406f6dd17e5e7f90822b85f07ab7\", \"sync_integration_tests\": \"15afb3ed445a2377df978cbb9949e8585cfff23e\", \"traffic_annotation_auditor_unittests\": \"b40434245e6042e6468c76a418f743f0e7dd919a\", \"ui_base_unittests\": \"d88c45065772b4376ebab29f1b19be86da84d7fa\", \"ui_chromeos_unittests\": \"338ddd2100d89d2d006b1dc1de513ba4fb9da75a\", \"ui_touch_selection_unittests\": \"859c6bf721500dacf31cbae7f1ebae160652b5ac\", \"unit_tests\": \"8e23deda504e841f47b07fbef9b531de51efa6f1\", \"url_unittests\": \"e42def75b7c410174b4679d97c9b29f7008eb508\", \"usage_time_limit_unittests\": \"e176387b1aa542296aaa87455d86c663c01d8599\", \"views_unittests\": \"7d244a8f09fac8751d20cbb2b85d4352c740a25b\", \"viz_unittests\": \"a3da99223bb108017e0ca7f9c739ad91b9dbf99f\", \"wm_unittests\": \"8f11c4cf7c1fefccad6085db636dd2570f7b39d8\", \"wtf_unittests\": \"74b2af4894ae120a0c58dd0baf961c26d36c4d54\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4221-9c50278\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"5 tests failed: ['browser_tests', 'non_network_service_browser_tests', 'non_single_process_mash_browser_tests', 'viz_browser_tests', 'non_network_service_interactive_ui_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1553685502948823",
"status": "COMPLETED",
"status_changed_ts": "1553685505270631",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11567",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f9355806e1184c010f161268d86641db2e052fb9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9355806e1184c010f161268d86641db2e052fb9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083266868912130032",
"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/8917836806686798608/+/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:43d7aac832a5d910",
"user_agent:luci-scheduler"
],
"updated_ts": "1553691022770672",
"url": "https://ci.chromium.org/b/8917836806686798608",
"utcnow_ts": "1553691023362488"
}
}
[12:50:23.372] Invocation finished in 1h38m43.109476767s with status FAILED