[16:58:14.949] New invocation is queued and will start shortly
[16:58:16.028] Starting the invocation (attempt 1)
[16:58:16.068] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:58:16.068] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:58:16.069] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9078896409733159664",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"c79e2789ef3b0016d3ba6eaed4a232396ac56f5f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9078896409733159664",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/c79e2789ef3b0016d3ba6eaed4a232396ac56f5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c79e2789ef3b0016d3ba6eaed4a232396ac56f5f",
"gitiles_ref:refs/heads/master"
]
}
[16:58:18.076] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1557853096921907",
"id": "8913466347001480368",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c79e2789ef3b0016d3ba6eaed4a232396ac56f5f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557853097869959",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12385",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c79e2789ef3b0016d3ba6eaed4a232396ac56f5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c79e2789ef3b0016d3ba6eaed4a232396ac56f5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078896409733159664",
"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/8913466347001480368/+/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": "1557853097870090",
"url": "https://ci.chromium.org/b/8913466347001480368",
"utcnow_ts": "1557853098062070"
}
}
[16:58:18.076] Task URL: https://ci.chromium.org/b/8913466347001480368
[16:58:18.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:2:0) after 1m0s
[16:59:18.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:2:0)
[16:59:18.110] Timer tick, asking Buildbucket for the build status
[16:59:18.246] Build 8913466347001480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:59:18.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:3:0) after 1m0s
[17:00:18.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:3:0)
[17:00:18.271] Timer tick, asking Buildbucket for the build status
[17:00:18.669] Build 8913466347001480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:18.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:4:0) after 1m0s
[17:01:18.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:4:0)
[17:01:18.707] Timer tick, asking Buildbucket for the build status
[17:01:20.121] Build 8913466347001480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:20.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:5:0) after 1m0s
[17:02:20.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:5:0)
[17:02:20.197] Timer tick, asking Buildbucket for the build status
[17:02:20.673] Build 8913466347001480368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:20.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:6:0) after 1m0s
[17:02:53.121] Received PubSub notification, asking Buildbucket for the build status
[17:02:53.360] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:20.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:6:0)
[17:03:20.710] Timer tick, asking Buildbucket for the build status
[17:03:21.111] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:21.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:8:0) after 1m0s
[17:04:21.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:8:0)
[17:04:21.147] Timer tick, asking Buildbucket for the build status
[17:04:22.479] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:22.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:9:0) after 1m0s
[17:05:22.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:9:0)
[17:05:22.500] Timer tick, asking Buildbucket for the build status
[17:05:23.910] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:23.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:10:0) after 1m0s
[17:06:23.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:10:0)
[17:06:23.917] Timer tick, asking Buildbucket for the build status
[17:06:24.026] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:24.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:11:0) after 1m0s
[17:07:24.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:11:0)
[17:07:24.065] Timer tick, asking Buildbucket for the build status
[17:07:24.708] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:24.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:12:0) after 1m0s
[17:08:24.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:12:0)
[17:08:24.728] Timer tick, asking Buildbucket for the build status
[17:08:25.880] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:25.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:13:0) after 1m0s
[17:09:25.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:13:0)
[17:09:25.934] Timer tick, asking Buildbucket for the build status
[17:09:26.149] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:26.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:14:0) after 1m0s
[17:10:26.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:14:0)
[17:10:26.138] Timer tick, asking Buildbucket for the build status
[17:10:28.463] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:28.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:15:0) after 1m0s
[17:11:28.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:15:0)
[17:11:28.492] Timer tick, asking Buildbucket for the build status
[17:11:28.638] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:28.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:16:0) after 1m0s
[17:12:28.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:16:0)
[17:12:28.645] Timer tick, asking Buildbucket for the build status
[17:12:30.364] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:30.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:17:0) after 1m0s
[17:13:30.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:17:0)
[17:13:30.398] Timer tick, asking Buildbucket for the build status
[17:13:30.962] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:30.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:18:0) after 1m0s
[17:14:30.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:18:0)
[17:14:30.986] Timer tick, asking Buildbucket for the build status
[17:14:31.167] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:31.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:19:0) after 1m0s
[17:15:31.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:19:0)
[17:15:31.179] Timer tick, asking Buildbucket for the build status
[17:15:32.047] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:32.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:20:0) after 1m0s
[17:16:32.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:20:0)
[17:16:32.072] Timer tick, asking Buildbucket for the build status
[17:16:33.199] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:33.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:21:0) after 1m0s
[17:17:33.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:21:0)
[17:17:33.244] Timer tick, asking Buildbucket for the build status
[17:17:34.299] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:34.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:22:0) after 1m0s
[17:18:34.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:22:0)
[17:18:34.319] Timer tick, asking Buildbucket for the build status
[17:18:34.622] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:34.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:23:0) after 1m0s
[17:19:34.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:23:0)
[17:19:34.604] Timer tick, asking Buildbucket for the build status
[17:19:35.007] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:35.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:24:0) after 1m0s
[17:20:35.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:24:0)
[17:20:35.032] Timer tick, asking Buildbucket for the build status
[17:20:35.756] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:35.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:25:0) after 1m0s
[17:21:35.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:25:0)
[17:21:35.810] Timer tick, asking Buildbucket for the build status
[17:21:36.027] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:36.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:26:0) after 1m0s
[17:22:36.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:26:0)
[17:22:36.032] Timer tick, asking Buildbucket for the build status
[17:22:36.431] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:36.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:27:0) after 1m0s
[17:23:36.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:27:0)
[17:23:36.441] Timer tick, asking Buildbucket for the build status
[17:23:36.540] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:36.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:28:0) after 1m0s
[17:24:36.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:28:0)
[17:24:36.564] Timer tick, asking Buildbucket for the build status
[17:24:37.345] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:37.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:29:0) after 1m0s
[17:25:37.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:29:0)
[17:25:37.349] Timer tick, asking Buildbucket for the build status
[17:25:37.609] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:37.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:30:0) after 1m0s
[17:26:37.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:30:0)
[17:26:37.630] Timer tick, asking Buildbucket for the build status
[17:26:38.371] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:38.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:31:0) after 1m0s
[17:27:38.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:31:0)
[17:27:38.351] Timer tick, asking Buildbucket for the build status
[17:27:40.259] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:40.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:32:0) after 1m0s
[17:28:40.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:32:0)
[17:28:40.309] Timer tick, asking Buildbucket for the build status
[17:28:41.407] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:41.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:33:0) after 1m0s
[17:29:41.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:33:0)
[17:29:41.431] Timer tick, asking Buildbucket for the build status
[17:29:42.221] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:42.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:34:0) after 1m0s
[17:30:42.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:34:0)
[17:30:42.243] Timer tick, asking Buildbucket for the build status
[17:30:43.148] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:43.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:35:0) after 1m0s
[17:31:43.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:35:0)
[17:31:43.168] Timer tick, asking Buildbucket for the build status
[17:31:43.453] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:43.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:36:0) after 1m0s
[17:32:43.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:36:0)
[17:32:43.463] Timer tick, asking Buildbucket for the build status
[17:32:43.776] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:43.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:37:0) after 1m0s
[17:33:43.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:37:0)
[17:33:43.786] Timer tick, asking Buildbucket for the build status
[17:33:43.904] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:43.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:38:0) after 1m0s
[17:34:43.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:38:0)
[17:34:43.921] Timer tick, asking Buildbucket for the build status
[17:34:44.259] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:44.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:39:0) after 1m0s
[17:35:44.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:39:0)
[17:35:44.270] Timer tick, asking Buildbucket for the build status
[17:35:44.422] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:44.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:40:0) after 1m0s
[17:36:44.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:40:0)
[17:36:44.469] Timer tick, asking Buildbucket for the build status
[17:36:44.674] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:44.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:41:0) after 1m0s
[17:37:44.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:41:0)
[17:37:44.734] Timer tick, asking Buildbucket for the build status
[17:37:44.869] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:44.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:42:0) after 1m0s
[17:38:44.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:42:0)
[17:38:44.873] Timer tick, asking Buildbucket for the build status
[17:38:45.349] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:45.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:43:0) after 1m0s
[17:39:45.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:43:0)
[17:39:45.406] Timer tick, asking Buildbucket for the build status
[17:39:45.563] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:45.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:44:0) after 1m0s
[17:40:45.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:44:0)
[17:40:45.662] Timer tick, asking Buildbucket for the build status
[17:40:46.835] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:46.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:45:0) after 1m0s
[17:41:46.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:45:0)
[17:41:46.989] Timer tick, asking Buildbucket for the build status
[17:41:48.337] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:48.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:46:0) after 1m0s
[17:42:48.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:46:0)
[17:42:48.333] Timer tick, asking Buildbucket for the build status
[17:42:49.218] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:49.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:47:0) after 1m0s
[17:43:49.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:47:0)
[17:43:49.253] Timer tick, asking Buildbucket for the build status
[17:43:49.917] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:49.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:48:0) after 1m0s
[17:44:49.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:48:0)
[17:44:49.907] Timer tick, asking Buildbucket for the build status
[17:44:50.273] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:50.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:49:0) after 1m0s
[17:45:50.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:49:0)
[17:45:50.285] Timer tick, asking Buildbucket for the build status
[17:45:50.447] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:50.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:50:0) after 1m0s
[17:46:50.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:50:0)
[17:46:50.449] Timer tick, asking Buildbucket for the build status
[17:46:52.422] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:52.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:51:0) after 1m0s
[17:47:52.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:51:0)
[17:47:52.454] Timer tick, asking Buildbucket for the build status
[17:47:52.860] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:52.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:52:0) after 1m0s
[17:48:52.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:52:0)
[17:48:52.886] Timer tick, asking Buildbucket for the build status
[17:48:53.143] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:53.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:53:0) after 1m0s
[17:49:53.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:53:0)
[17:49:53.270] Timer tick, asking Buildbucket for the build status
[17:49:53.658] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:53.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:54:0) after 1m0s
[17:50:53.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:54:0)
[17:50:53.670] Timer tick, asking Buildbucket for the build status
[17:50:55.187] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:55.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:55:0) after 1m0s
[17:51:55.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:55:0)
[17:51:55.167] Timer tick, asking Buildbucket for the build status
[17:51:58.134] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:58.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:56:0) after 1m0s
[17:52:58.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:56:0)
[17:52:58.195] Timer tick, asking Buildbucket for the build status
[17:52:59.873] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:59.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:57:0) after 1m0s
[17:53:59.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:57:0)
[17:53:59.965] Timer tick, asking Buildbucket for the build status
[17:54:01.384] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:01.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:58:0) after 1m0s
[17:55:01.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:58:0)
[17:55:01.409] Timer tick, asking Buildbucket for the build status
[17:55:01.583] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:01.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:59:0) after 1m0s
[17:56:01.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:59:0)
[17:56:01.618] Timer tick, asking Buildbucket for the build status
[17:56:02.364] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:02.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:60:0) after 1m0s
[17:57:02.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:60:0)
[17:57:02.998] Timer tick, asking Buildbucket for the build status
[17:57:03.549] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:03.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:61:0) after 1m0s
[17:58:03.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:61:0)
[17:58:03.575] Timer tick, asking Buildbucket for the build status
[17:58:04.358] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:04.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:62:0) after 1m0s
[17:59:04.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:62:0)
[17:59:04.387] Timer tick, asking Buildbucket for the build status
[17:59:04.641] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:04.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:63:0) after 1m0s
[18:00:04.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:63:0)
[18:00:04.659] Timer tick, asking Buildbucket for the build status
[18:00:06.179] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:06.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:64:0) after 1m0s
[18:01:06.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:64:0)
[18:01:06.215] Timer tick, asking Buildbucket for the build status
[18:01:08.778] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:08.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:65:0) after 1m0s
[18:02:08.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:65:0)
[18:02:08.802] Timer tick, asking Buildbucket for the build status
[18:02:09.534] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:09.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:66:0) after 1m0s
[18:03:09.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:66:0)
[18:03:09.537] Timer tick, asking Buildbucket for the build status
[18:03:10.303] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:10.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:67:0) after 1m0s
[18:04:10.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:67:0)
[18:04:10.330] Timer tick, asking Buildbucket for the build status
[18:04:10.614] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:10.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:68:0) after 1m0s
[18:05:10.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:68:0)
[18:05:10.656] Timer tick, asking Buildbucket for the build status
[18:05:11.002] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:11.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:69:0) after 1m0s
[18:06:11.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:69:0)
[18:06:11.031] Timer tick, asking Buildbucket for the build status
[18:06:13.046] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:13.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:70:0) after 1m0s
[18:07:13.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:70:0)
[18:07:13.155] Timer tick, asking Buildbucket for the build status
[18:07:13.493] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:13.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:71:0) after 1m0s
[18:08:13.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:71:0)
[18:08:13.517] Timer tick, asking Buildbucket for the build status
[18:08:15.777] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:15.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:72:0) after 1m0s
[18:09:15.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:72:0)
[18:09:15.798] Timer tick, asking Buildbucket for the build status
[18:09:17.900] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:17.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:73:0) after 1m0s
[18:10:17.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:73:0)
[18:10:17.930] Timer tick, asking Buildbucket for the build status
[18:10:18.469] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:18.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:74:0) after 1m0s
[18:11:18.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:74:0)
[18:11:18.488] Timer tick, asking Buildbucket for the build status
[18:11:20.602] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:20.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:75:0) after 1m0s
[18:12:20.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:75:0)
[18:12:20.606] Timer tick, asking Buildbucket for the build status
[18:12:21.190] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:21.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:76:0) after 1m0s
[18:13:21.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:76:0)
[18:13:21.239] Timer tick, asking Buildbucket for the build status
[18:13:21.442] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:21.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:77:0) after 1m0s
[18:14:21.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:77:0)
[18:14:21.598] Timer tick, asking Buildbucket for the build status
[18:14:22.133] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:22.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:78:0) after 1m0s
[18:15:22.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:78:0)
[18:15:22.162] Timer tick, asking Buildbucket for the build status
[18:15:22.416] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:22.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:79:0) after 1m0s
[18:16:22.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:79:0)
[18:16:22.435] Timer tick, asking Buildbucket for the build status
[18:16:22.798] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:22.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:80:0) after 1m0s
[18:17:24.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:80:0)
[18:17:24.198] Timer tick, asking Buildbucket for the build status
[18:17:27.807] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:27.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:81:0) after 1m0s
[18:18:27.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:81:0)
[18:18:27.839] Timer tick, asking Buildbucket for the build status
[18:18:29.205] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:29.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:82:0) after 1m0s
[18:19:29.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:82:0)
[18:19:29.229] Timer tick, asking Buildbucket for the build status
[18:19:30.213] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:30.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:83:0) after 1m0s
[18:20:30.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:83:0)
[18:20:30.237] Timer tick, asking Buildbucket for the build status
[18:20:30.584] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:30.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:84:0) after 1m0s
[18:21:30.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:84:0)
[18:21:30.705] Timer tick, asking Buildbucket for the build status
[18:21:32.787] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:32.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:85:0) after 1m0s
[18:22:32.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:85:0)
[18:22:32.815] Timer tick, asking Buildbucket for the build status
[18:22:33.128] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:33.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:86:0) after 1m0s
[18:23:33.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:86:0)
[18:23:33.107] Timer tick, asking Buildbucket for the build status
[18:23:33.378] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:33.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:87:0) after 1m0s
[18:24:33.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:87:0)
[18:24:33.391] Timer tick, asking Buildbucket for the build status
[18:24:33.797] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:33.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:88:0) after 1m0s
[18:25:33.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:88:0)
[18:25:33.788] Timer tick, asking Buildbucket for the build status
[18:25:34.591] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:34.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:89:0) after 1m0s
[18:26:34.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:89:0)
[18:26:34.605] Timer tick, asking Buildbucket for the build status
[18:26:34.827] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:34.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:90:0) after 1m0s
[18:27:34.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:90:0)
[18:27:34.843] Timer tick, asking Buildbucket for the build status
[18:27:35.258] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:35.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:91:0) after 1m0s
[18:28:35.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:91:0)
[18:28:35.338] Timer tick, asking Buildbucket for the build status
[18:28:35.644] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:35.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:92:0) after 1m0s
[18:29:35.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:92:0)
[18:29:35.664] Timer tick, asking Buildbucket for the build status
[18:29:36.409] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:36.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:93:0) after 1m0s
[18:30:36.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:93:0)
[18:30:36.444] Timer tick, asking Buildbucket for the build status
[18:30:37.173] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:37.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:94:0) after 1m0s
[18:31:37.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:94:0)
[18:31:37.199] Timer tick, asking Buildbucket for the build status
[18:31:37.387] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:37.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:95:0) after 1m0s
[18:32:37.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:95:0)
[18:32:37.539] Timer tick, asking Buildbucket for the build status
[18:32:38.108] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:38.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:96:0) after 1m0s
[18:33:38.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:96:0)
[18:33:38.116] Timer tick, asking Buildbucket for the build status
[18:33:38.580] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:38.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:97:0) after 1m0s
[18:34:38.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:97:0)
[18:34:38.623] Timer tick, asking Buildbucket for the build status
[18:34:40.351] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:40.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:98:0) after 1m0s
[18:35:40.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:98:0)
[18:35:40.394] Timer tick, asking Buildbucket for the build status
[18:35:40.839] Build 8913466347001480368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:40.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078896409733159664:99:0) after 1m0s
[18:36:24.555] Received PubSub notification, asking Buildbucket for the build status
[18:36:24.784] Build 8913466347001480368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:36:24.784] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1557858982839018",
"created_by": "project:chromium",
"created_ts": "1557853096921907",
"id": "8913466347001480368",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c79e2789ef3b0016d3ba6eaed4a232396ac56f5f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": 12385, \"got_angle_revision\": \"01cd5697760e6df88936b0d99dee740130956d49\", \"got_dawn_revision\": \"2e56970932ec01ef2b030fe6b27f305c7733a47f\", \"got_nacl_revision\": \"ca374f5112fca6b36fc5d73e117a60b82f394993\", \"got_revision\": \"c79e2789ef3b0016d3ba6eaed4a232396ac56f5f\", \"got_revision_cp\": \"refs/heads/master@{#659545}\", \"got_swarming_client_revision\": \"1b65f4e862045f3ba430a4cbd0643f5b1b66c230\", \"got_v8_revision\": \"4a82ea5df159a4bd2d03ccb5b4785f7b14bc9c07\", \"got_v8_revision_cp\": \"refs/heads/7.6.178@{#1}\", \"got_webrtc_revision\": \"e62a08a87a6f21672b2ae8ba25632007f417a3f1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27934}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c79e2789ef3b0016d3ba6eaed4a232396ac56f5f\", \"swarm_hashes\": {\"accessibility_unittests\": \"3f00d13c8174509e1234616841b419151c80ae94\", \"angle_unittests\": \"3572e96480af45aa6a913051a1c0a30379ec0f1f\", \"app_list_unittests\": \"5900799d2294699909ceac29161be073063923d6\", \"app_shell_unittests\": \"e61e7069058cdd93bc29ca57e16902786b414ed6\", \"ash_unittests\": \"9c0282128c2b7a30997e9b335fff75436d8fdd4c\", \"aura_unittests\": \"6c444ad99dd82240ec4aad54a43b278e3dcaec5e\", \"base_unittests\": \"271e2e02d54bed1d6c89f322fa5cfac6eeac8753\", \"base_util_unittests\": \"9726f71794a356e532684fb3ff01e2c6716cfb48\", \"blink_common_unittests\": \"ec918f775e8d563b5555cd640602580767f31ca2\", \"blink_fuzzer_unittests\": \"0708c4f7945a76d7fb7f1dfe3a9097da03a335db\", \"blink_heap_unittests\": \"b58f31e01342937295c446454f21cc8be5315e98\", \"blink_platform_unittests\": \"a053efdec42c4dc64b02cb0ac8112677e5650e73\", \"blink_unittests\": \"2beb266aa736dd2889043b72d483feb80b804de3\", \"boringssl_crypto_tests\": \"546fd40962cac2192bc7c53e49a25cfd5c26d910\", \"boringssl_ssl_tests\": \"c6ef206cecb1a79d6ca37367148d38a1e2f0aabf\", \"browser_tests\": \"349feb73e14ea21a3ecbdb9a3a52606a2e1152cd\", \"cacheinvalidation_unittests\": \"4ed3b55112b02b4e0f3f1899939fee3ae3eaf800\", \"capture_unittests\": \"646709b9e48d4645a3862f685db77e6c18872848\", \"cast_unittests\": \"12d30e046ec8454e5681592e0af0c90956ee9db0\", \"cc_unittests\": \"834856b5d8c08a1078b39b7a6f8c008cc30584e0\", \"chrome_app_unittests\": \"17da44a55ffacd1aa260b9badca4b8a06fbfa974\", \"chromedriver_unittests\": \"e2e2b6a96668fb56f02b82ca9f7374a89d7ab5d3\", \"chromeos_components_unittests\": \"357b3e7206fc7d4af09a22ac204c189cba803866\", \"chromeos_unittests\": \"7701ba0a871e99b817634e869d3a17f106a3d036\", \"components_browsertests\": \"7275d0dd6cada7d854eac31f4279f15efca7891b\", \"components_unittests\": \"33edfdd30feb5fdbbea5d3d87b2b4056f8bfae8e\", \"compositor_unittests\": \"4361beec7b52122dc0cf8037ac92b130c0dfa2c6\", \"content_browsertests\": \"0d36dc3e37f3ce34bc70cd64c6dfca58d1a8a5e0\", \"content_unittests\": \"48c542add70c682e39362f369eb6b08f354946b4\", \"crypto_unittests\": \"a5a7a68beee12e298580e0875a5de53769b12f68\", \"dbus_unittests\": \"64c99eee64124a8865fe071ff7cce984fc71024d\", \"device_unittests\": \"483605a7b20acf8ba96abb943edb6a3dff271a65\", \"display_unittests\": \"1ca53c5f3561e2ea2f46c281c725569ed3efd2c1\", \"events_unittests\": \"0a42e33fe6abfa26bae7bef718e0ee5050a252cf\", \"exo_unittests\": \"990ac861231457b69495dbc9c6515d8785816695\", \"extensions_browsertests\": \"19fd2e36ff25a9c02d53c962f713451a21ded79f\", \"extensions_unittests\": \"a9cf807485b009ecab9982da8a7810fe3d36ff11\", \"filesystem_service_unittests\": \"0d4336c46bc374898f25f3441c3be20a5aa1e3b0\", \"gcm_unit_tests\": \"c7c8a498c849018cbb4796a7d512686a4c1cb081\", \"gfx_unittests\": \"959a230eb5a42bfc64231b037c628b473a279f93\", \"gin_unittests\": \"130f7054446e19f8b7319e3dece2723f5cbe9650\", \"gl_unittests_ozone\": \"910107112f7e9b83c97e8b6c7c5dbae7b24c9dac\", \"google_apis_unittests\": \"3406b2e90271f6df82f4c3391f6a2a297b5a158c\", \"gpu_unittests\": \"27afced1cdc6c2b69d7291071b58664acf008322\", \"interactive_ui_tests\": \"381d74924e678adba876d28370ad6c3eb8a40ff0\", \"ipc_tests\": \"a1447d695a0197f82f9da15bd21c68c529d9bd00\", \"jingle_unittests\": \"a3ec5e1254bba2422875bd18ee125637ed52c999\", \"keyboard_unittests\": \"29592c137f039a407cdbef56d8aac6a6adc54638\", \"latency_unittests\": \"af2909d04cadc9938411aa65770daca6ddca702b\", \"leveldb_service_unittests\": \"77858eaecea34d0fcb1c2da1f26ed97595982037\", \"libjingle_xmpp_unittests\": \"435824c889c20fcc88d180a6b07580d7b75896b3\", \"media_blink_unittests\": \"82e4fd175f976419579d6b782d2c7d7cb13a74f4\", \"media_service_unittests\": \"c638abdf3d9feb00864a4476e2eb0d0c1c4beae5\", \"media_unittests\": \"fdb6be5fe0fc7786e5d4a598446b92c5d7b1fccd\", \"message_center_unittests\": \"863c3b9517a47bb07f12a0ce5727799b030cde32\", \"midi_unittests\": \"6020ed9f969094af853c18f49c6052af85bfcc28\", \"mojo_core_unittests\": \"deb8416f88b315ad3e1e460ed8a5884d791f6d54\", \"mojo_unittests\": \"c45ee471cdeeac1073682f27dc933496c3371e2a\", \"nacl_helper_nonsfi_unittests\": \"e87211242c6b419de1270119eb2ee50ce07cd99b\", \"nacl_loader_unittests\": \"a55929390c6f0898ff8b63240d927680fefc2914\", \"native_theme_unittests\": \"49a1a237f7d4dd41ab75284c5d476ce49b7c62bb\", \"net_unittests\": \"ac5f1cce7b3c9cdfccf4dfdae76539d7f585d18c\", \"ozone_gl_unittests\": \"f30509b533b203f2d424d2bc200a68e16e57cd19\", \"ozone_unittests\": \"23ef7aec3dbd1cc8e04b32088d3b9f3964d808b3\", \"ozone_x11_unittests\": \"5177c194e2e7a2419ec1274669d51e9d788b9fce\", \"pdf_unittests\": \"99fb01910736c3e8f68eb15eb6dfc8732ecf913c\", \"perfetto_unittests\": \"6ba4f388df7624726f0a70af9eb7e5c0e7490267\", \"ppapi_unittests\": \"5f1dcad69fd7f488436dc9d9805e88e0714d3bb4\", \"printing_unittests\": \"7142925f5cc1d776aa0f5ae99b0eada03f95b937\", \"remoting_unittests\": \"12f29ae5cc13f813f75fa508d0e5cc4955285c4f\", \"sandbox_linux_unittests\": \"0965db779ae6f9b46ace9689e445dfcd11a6fa34\", \"service_manager_unittests\": \"3934924790ac4756c01d882cde281fc8f475e4ae\", \"services_unittests\": \"61f4641af4f539af4e660a2173222656173ba92f\", \"shell_dialogs_unittests\": \"3ce2a32688aae0ef9aef0d394b9fccd1a7d720f9\", \"skia_unittests\": \"af85b65b62b7f6fe703ace3fcb1f39dad5091360\", \"snapshot_unittests\": \"cc9d744761ffb2af678d7eda8887ae0d432f5a20\", \"sql_unittests\": \"6a1a1b8087ed5bbc4998a8b39e9c4ca318660fc8\", \"storage_unittests\": \"dc39ac4bf93defeae311fdc2880c1a05064c1761\", \"sync_integration_tests\": \"93c2b6241152fa9d338063c84158debfacaeab48\", \"traffic_annotation_auditor_unittests\": \"2848164ed678473beaf0befcfe034f61e63ea49d\", \"ui_base_unittests\": \"0cacf10001a4b1d6cdccda270927310fea9854c7\", \"ui_chromeos_unittests\": \"6f4c15341fb1b7c9e56081ba71f4043c14a2eb51\", \"ui_touch_selection_unittests\": \"0195831eee5bdafab069ad9e0a4b051ff383a809\", \"unit_tests\": \"42861a1f0ca563ac13d9f6aed7d3f53a7fde896c\", \"url_unittests\": \"9cd1951a24887659530a096b7720a8dba86a0d2c\", \"usage_time_limit_unittests\": \"303cf0988af63d80424bd98f14ec4bae1c35a9d2\", \"views_unittests\": \"88b75eea013b85783dbeffd6287f017a189fff19\", \"viz_unittests\": \"3c492d7f4d4852c75d72f7fb6653bfa2758fe898\", \"wm_unittests\": \"074bd02dd327b2e80211b93b335818b918ad0b84\", \"wtf_unittests\": \"464d780d1c09258ab981add9e7b0031a97b17cfa\"}, \"swarm_hashes_refs/heads/master(at){#659545}_without_patch\": {\"accessibility_unittests\": \"3f00d13c8174509e1234616841b419151c80ae94\", \"angle_unittests\": \"3572e96480af45aa6a913051a1c0a30379ec0f1f\", \"app_list_unittests\": \"5900799d2294699909ceac29161be073063923d6\", \"app_shell_unittests\": \"e61e7069058cdd93bc29ca57e16902786b414ed6\", \"ash_unittests\": \"9c0282128c2b7a30997e9b335fff75436d8fdd4c\", \"aura_unittests\": \"6c444ad99dd82240ec4aad54a43b278e3dcaec5e\", \"base_unittests\": \"271e2e02d54bed1d6c89f322fa5cfac6eeac8753\", \"base_util_unittests\": \"9726f71794a356e532684fb3ff01e2c6716cfb48\", \"blink_common_unittests\": \"ec918f775e8d563b5555cd640602580767f31ca2\", \"blink_fuzzer_unittests\": \"0708c4f7945a76d7fb7f1dfe3a9097da03a335db\", \"blink_heap_unittests\": \"b58f31e01342937295c446454f21cc8be5315e98\", \"blink_platform_unittests\": \"a053efdec42c4dc64b02cb0ac8112677e5650e73\", \"blink_unittests\": \"2beb266aa736dd2889043b72d483feb80b804de3\", \"boringssl_crypto_tests\": \"546fd40962cac2192bc7c53e49a25cfd5c26d910\", \"boringssl_ssl_tests\": \"c6ef206cecb1a79d6ca37367148d38a1e2f0aabf\", \"browser_tests\": \"349feb73e14ea21a3ecbdb9a3a52606a2e1152cd\", \"cacheinvalidation_unittests\": \"4ed3b55112b02b4e0f3f1899939fee3ae3eaf800\", \"capture_unittests\": \"646709b9e48d4645a3862f685db77e6c18872848\", \"cast_unittests\": \"12d30e046ec8454e5681592e0af0c90956ee9db0\", \"cc_unittests\": \"834856b5d8c08a1078b39b7a6f8c008cc30584e0\", \"chrome_app_unittests\": \"17da44a55ffacd1aa260b9badca4b8a06fbfa974\", \"chromedriver_unittests\": \"e2e2b6a96668fb56f02b82ca9f7374a89d7ab5d3\", \"chromeos_components_unittests\": \"357b3e7206fc7d4af09a22ac204c189cba803866\", \"chromeos_unittests\": \"7701ba0a871e99b817634e869d3a17f106a3d036\", \"components_browsertests\": \"7275d0dd6cada7d854eac31f4279f15efca7891b\", \"components_unittests\": \"33edfdd30feb5fdbbea5d3d87b2b4056f8bfae8e\", \"compositor_unittests\": \"4361beec7b52122dc0cf8037ac92b130c0dfa2c6\", \"content_browsertests\": \"0d36dc3e37f3ce34bc70cd64c6dfca58d1a8a5e0\", \"content_unittests\": \"48c542add70c682e39362f369eb6b08f354946b4\", \"crypto_unittests\": \"a5a7a68beee12e298580e0875a5de53769b12f68\", \"dbus_unittests\": \"64c99eee64124a8865fe071ff7cce984fc71024d\", \"device_unittests\": \"483605a7b20acf8ba96abb943edb6a3dff271a65\", \"display_unittests\": \"1ca53c5f3561e2ea2f46c281c725569ed3efd2c1\", \"events_unittests\": \"0a42e33fe6abfa26bae7bef718e0ee5050a252cf\", \"exo_unittests\": \"990ac861231457b69495dbc9c6515d8785816695\", \"extensions_browsertests\": \"19fd2e36ff25a9c02d53c962f713451a21ded79f\", \"extensions_unittests\": \"a9cf807485b009ecab9982da8a7810fe3d36ff11\", \"filesystem_service_unittests\": \"0d4336c46bc374898f25f3441c3be20a5aa1e3b0\", \"gcm_unit_tests\": \"c7c8a498c849018cbb4796a7d512686a4c1cb081\", \"gfx_unittests\": \"959a230eb5a42bfc64231b037c628b473a279f93\", \"gin_unittests\": \"130f7054446e19f8b7319e3dece2723f5cbe9650\", \"gl_unittests_ozone\": \"910107112f7e9b83c97e8b6c7c5dbae7b24c9dac\", \"google_apis_unittests\": \"3406b2e90271f6df82f4c3391f6a2a297b5a158c\", \"gpu_unittests\": \"27afced1cdc6c2b69d7291071b58664acf008322\", \"interactive_ui_tests\": \"381d74924e678adba876d28370ad6c3eb8a40ff0\", \"ipc_tests\": \"a1447d695a0197f82f9da15bd21c68c529d9bd00\", \"jingle_unittests\": \"a3ec5e1254bba2422875bd18ee125637ed52c999\", \"keyboard_unittests\": \"29592c137f039a407cdbef56d8aac6a6adc54638\", \"latency_unittests\": \"af2909d04cadc9938411aa65770daca6ddca702b\", \"leveldb_service_unittests\": \"77858eaecea34d0fcb1c2da1f26ed97595982037\", \"libjingle_xmpp_unittests\": \"435824c889c20fcc88d180a6b07580d7b75896b3\", \"media_blink_unittests\": \"82e4fd175f976419579d6b782d2c7d7cb13a74f4\", \"media_service_unittests\": \"c638abdf3d9feb00864a4476e2eb0d0c1c4beae5\", \"media_unittests\": \"fdb6be5fe0fc7786e5d4a598446b92c5d7b1fccd\", \"message_center_unittests\": \"863c3b9517a47bb07f12a0ce5727799b030cde32\", \"midi_unittests\": \"6020ed9f969094af853c18f49c6052af85bfcc28\", \"mojo_core_unittests\": \"deb8416f88b315ad3e1e460ed8a5884d791f6d54\", \"mojo_unittests\": \"c45ee471cdeeac1073682f27dc933496c3371e2a\", \"nacl_helper_nonsfi_unittests\": \"e87211242c6b419de1270119eb2ee50ce07cd99b\", \"nacl_loader_unittests\": \"a55929390c6f0898ff8b63240d927680fefc2914\", \"native_theme_unittests\": \"49a1a237f7d4dd41ab75284c5d476ce49b7c62bb\", \"net_unittests\": \"ac5f1cce7b3c9cdfccf4dfdae76539d7f585d18c\", \"ozone_gl_unittests\": \"f30509b533b203f2d424d2bc200a68e16e57cd19\", \"ozone_unittests\": \"23ef7aec3dbd1cc8e04b32088d3b9f3964d808b3\", \"ozone_x11_unittests\": \"5177c194e2e7a2419ec1274669d51e9d788b9fce\", \"pdf_unittests\": \"99fb01910736c3e8f68eb15eb6dfc8732ecf913c\", \"perfetto_unittests\": \"6ba4f388df7624726f0a70af9eb7e5c0e7490267\", \"ppapi_unittests\": \"5f1dcad69fd7f488436dc9d9805e88e0714d3bb4\", \"printing_unittests\": \"7142925f5cc1d776aa0f5ae99b0eada03f95b937\", \"remoting_unittests\": \"12f29ae5cc13f813f75fa508d0e5cc4955285c4f\", \"sandbox_linux_unittests\": \"0965db779ae6f9b46ace9689e445dfcd11a6fa34\", \"service_manager_unittests\": \"3934924790ac4756c01d882cde281fc8f475e4ae\", \"services_unittests\": \"61f4641af4f539af4e660a2173222656173ba92f\", \"shell_dialogs_unittests\": \"3ce2a32688aae0ef9aef0d394b9fccd1a7d720f9\", \"skia_unittests\": \"af85b65b62b7f6fe703ace3fcb1f39dad5091360\", \"snapshot_unittests\": \"cc9d744761ffb2af678d7eda8887ae0d432f5a20\", \"sql_unittests\": \"6a1a1b8087ed5bbc4998a8b39e9c4ca318660fc8\", \"storage_unittests\": \"dc39ac4bf93defeae311fdc2880c1a05064c1761\", \"sync_integration_tests\": \"93c2b6241152fa9d338063c84158debfacaeab48\", \"traffic_annotation_auditor_unittests\": \"2848164ed678473beaf0befcfe034f61e63ea49d\", \"ui_base_unittests\": \"0cacf10001a4b1d6cdccda270927310fea9854c7\", \"ui_chromeos_unittests\": \"6f4c15341fb1b7c9e56081ba71f4043c14a2eb51\", \"ui_touch_selection_unittests\": \"0195831eee5bdafab069ad9e0a4b051ff383a809\", \"unit_tests\": \"42861a1f0ca563ac13d9f6aed7d3f53a7fde896c\", \"url_unittests\": \"9cd1951a24887659530a096b7720a8dba86a0d2c\", \"usage_time_limit_unittests\": \"303cf0988af63d80424bd98f14ec4bae1c35a9d2\", \"views_unittests\": \"88b75eea013b85783dbeffd6287f017a189fff19\", \"viz_unittests\": \"3c492d7f4d4852c75d72f7fb6653bfa2758fe898\", \"wm_unittests\": \"074bd02dd327b2e80211b93b335818b918ad0b84\", \"wtf_unittests\": \"464d780d1c09258ab981add9e7b0031a97b17cfa\"}}, \"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\"], \"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\": [\"4293-d3520ea\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557853366942712",
"status": "COMPLETED",
"status_changed_ts": "1557858983730974",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12385",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c79e2789ef3b0016d3ba6eaed4a232396ac56f5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c79e2789ef3b0016d3ba6eaed4a232396ac56f5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078896409733159664",
"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/8913466347001480368/+/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:44d0195e844e2b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1557858983733905",
"url": "https://ci.chromium.org/b/8913466347001480368",
"utcnow_ts": "1557858984773394"
}
}
[18:36:24.784] Invocation finished in 1h38m9.852639111s with status SUCCEEDED