[15:53:40.327] New invocation is queued and will start shortly
[15:53:41.406] Starting the invocation (attempt 1)
[15:53:41.472] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:53:41.472] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:53:41.472] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9080078233129655584",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b893403b98970aec21b5e67c25c16edac9ccf92f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9080078233129655584",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/b893403b98970aec21b5e67c25c16edac9ccf92f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b893403b98970aec21b5e67c25c16edac9ccf92f",
"gitiles_ref:refs/heads/master"
]
}
[15:53:42.538] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1556726021685981",
"id": "8914648171043927488",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b893403b98970aec21b5e67c25c16edac9ccf92f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1556726022347905",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12159",
"builder:linux-chromeos-dbg",
"buildset:commit/git/b893403b98970aec21b5e67c25c16edac9ccf92f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b893403b98970aec21b5e67c25c16edac9ccf92f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080078233129655584",
"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/8914648171043927488/+/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": "1556726022348054",
"url": "https://ci.chromium.org/b/8914648171043927488",
"utcnow_ts": "1556726022522668"
}
}
[15:53:42.538] Task URL: https://ci.chromium.org/b/8914648171043927488
[15:53:42.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:2:0) after 1m0s
[15:53:44.721] Received PubSub notification, asking Buildbucket for the build status
[15:53:44.815] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:42.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:2:0)
[15:54:42.568] Timer tick, asking Buildbucket for the build status
[15:54:42.774] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:42.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:4:0) after 1m0s
[15:55:42.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:4:0)
[15:55:42.798] Timer tick, asking Buildbucket for the build status
[15:55:43.749] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:43.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:5:0) after 1m0s
[15:56:43.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:5:0)
[15:56:43.873] Timer tick, asking Buildbucket for the build status
[15:56:44.224] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:44.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:6:0) after 1m0s
[15:57:44.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:6:0)
[15:57:44.251] Timer tick, asking Buildbucket for the build status
[15:57:44.428] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:44.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:7:0) after 1m0s
[15:58:44.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:7:0)
[15:58:44.456] Timer tick, asking Buildbucket for the build status
[15:58:45.174] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:45.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:8:0) after 1m0s
[15:59:45.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:8:0)
[15:59:45.203] Timer tick, asking Buildbucket for the build status
[15:59:45.341] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:45.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:9:0) after 1m0s
[16:00:45.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:9:0)
[16:00:45.366] Timer tick, asking Buildbucket for the build status
[16:00:45.655] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:45.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:10:0) after 1m0s
[16:01:45.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:10:0)
[16:01:45.693] Timer tick, asking Buildbucket for the build status
[16:01:46.573] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:46.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:11:0) after 1m0s
[16:02:46.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:11:0)
[16:02:46.605] Timer tick, asking Buildbucket for the build status
[16:02:47.648] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:47.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:12:0) after 1m0s
[16:03:47.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:12:0)
[16:03:47.677] Timer tick, asking Buildbucket for the build status
[16:03:47.909] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:47.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:13:0) after 1m0s
[16:04:47.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:13:0)
[16:04:47.919] Timer tick, asking Buildbucket for the build status
[16:04:48.137] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:48.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:14:0) after 1m0s
[16:05:48.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:14:0)
[16:05:48.216] Timer tick, asking Buildbucket for the build status
[16:05:48.417] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:48.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:15:0) after 1m0s
[16:06:48.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:15:0)
[16:06:48.402] Timer tick, asking Buildbucket for the build status
[16:06:48.594] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:48.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:16:0) after 1m0s
[16:07:48.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:16:0)
[16:07:48.629] Timer tick, asking Buildbucket for the build status
[16:07:49.078] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:49.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:17:0) after 1m0s
[16:08:49.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:17:0)
[16:08:49.109] Timer tick, asking Buildbucket for the build status
[16:08:49.755] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:49.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:18:0) after 1m0s
[16:09:49.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:18:0)
[16:09:49.775] Timer tick, asking Buildbucket for the build status
[16:09:50.396] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:50.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:19:0) after 1m0s
[16:10:50.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:19:0)
[16:10:50.429] Timer tick, asking Buildbucket for the build status
[16:10:50.520] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:50.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:20:0) after 1m0s
[16:11:50.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:20:0)
[16:11:50.495] Timer tick, asking Buildbucket for the build status
[16:11:50.593] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:50.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:21:0) after 1m0s
[16:12:50.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:21:0)
[16:12:50.609] Timer tick, asking Buildbucket for the build status
[16:12:50.994] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:50.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:22:0) after 1m0s
[16:13:51.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:22:0)
[16:13:51.014] Timer tick, asking Buildbucket for the build status
[16:13:51.347] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:51.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:23:0) after 1m0s
[16:14:51.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:23:0)
[16:14:51.379] Timer tick, asking Buildbucket for the build status
[16:14:52.124] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:52.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:24:0) after 1m0s
[16:15:52.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:24:0)
[16:15:52.111] Timer tick, asking Buildbucket for the build status
[16:15:52.262] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:52.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:25:0) after 1m0s
[16:16:52.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:25:0)
[16:16:52.296] Timer tick, asking Buildbucket for the build status
[16:16:52.425] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:52.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:26:0) after 1m0s
[16:17:52.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:26:0)
[16:17:52.421] Timer tick, asking Buildbucket for the build status
[16:17:53.401] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:53.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:27:0) after 1m0s
[16:18:53.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:27:0)
[16:18:53.384] Timer tick, asking Buildbucket for the build status
[16:18:53.841] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:53.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:28:0) after 1m0s
[16:19:53.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:28:0)
[16:19:53.833] Timer tick, asking Buildbucket for the build status
[16:19:56.565] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:56.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:29:0) after 1m0s
[16:20:56.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:29:0)
[16:20:56.593] Timer tick, asking Buildbucket for the build status
[16:20:57.362] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:57.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:30:0) after 1m0s
[16:21:57.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:30:0)
[16:21:57.361] Timer tick, asking Buildbucket for the build status
[16:21:57.791] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:57.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:31:0) after 1m0s
[16:22:57.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:31:0)
[16:22:57.790] Timer tick, asking Buildbucket for the build status
[16:22:58.192] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:58.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:32:0) after 1m0s
[16:23:58.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:32:0)
[16:23:58.224] Timer tick, asking Buildbucket for the build status
[16:23:58.708] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:58.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:33:0) after 1m0s
[16:24:58.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:33:0)
[16:24:58.732] Timer tick, asking Buildbucket for the build status
[16:24:59.056] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:59.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:34:0) after 1m0s
[16:25:59.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:34:0)
[16:25:59.078] Timer tick, asking Buildbucket for the build status
[16:26:01.380] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:01.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:35:0) after 1m0s
[16:27:01.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:35:0)
[16:27:01.400] Timer tick, asking Buildbucket for the build status
[16:27:02.142] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:02.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:36:0) after 1m0s
[16:28:02.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:36:0)
[16:28:02.177] Timer tick, asking Buildbucket for the build status
[16:28:02.573] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:02.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:37:0) after 1m0s
[16:29:02.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:37:0)
[16:29:02.598] Timer tick, asking Buildbucket for the build status
[16:29:03.326] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:03.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:38:0) after 1m0s
[16:30:03.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:38:0)
[16:30:03.355] Timer tick, asking Buildbucket for the build status
[16:30:05.604] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:05.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:39:0) after 1m0s
[16:31:05.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:39:0)
[16:31:05.608] Timer tick, asking Buildbucket for the build status
[16:31:06.219] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:06.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:40:0) after 1m0s
[16:32:06.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:40:0)
[16:32:06.259] Timer tick, asking Buildbucket for the build status
[16:32:06.447] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:06.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:41:0) after 1m0s
[16:33:06.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:41:0)
[16:33:06.489] Timer tick, asking Buildbucket for the build status
[16:33:06.773] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:06.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:42:0) after 1m0s
[16:34:06.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:42:0)
[16:34:06.777] Timer tick, asking Buildbucket for the build status
[16:34:08.592] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:08.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:43:0) after 1m0s
[16:35:08.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:43:0)
[16:35:08.634] Timer tick, asking Buildbucket for the build status
[16:35:09.002] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:09.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:44:0) after 1m0s
[16:36:08.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:44:0)
[16:36:08.989] Timer tick, asking Buildbucket for the build status
[16:36:09.296] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:09.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:45:0) after 1m0s
[16:37:09.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:45:0)
[16:37:09.324] Timer tick, asking Buildbucket for the build status
[16:37:09.527] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:09.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:46:0) after 1m0s
[16:38:09.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:46:0)
[16:38:09.567] Timer tick, asking Buildbucket for the build status
[16:38:09.762] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:09.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:47:0) after 1m0s
[16:39:09.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:47:0)
[16:39:09.829] Timer tick, asking Buildbucket for the build status
[16:39:09.980] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:09.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:48:0) after 1m0s
[16:40:10.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:48:0)
[16:40:10.006] Timer tick, asking Buildbucket for the build status
[16:40:10.498] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:10.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:49:0) after 1m0s
[16:41:10.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:49:0)
[16:41:10.478] Timer tick, asking Buildbucket for the build status
[16:41:11.232] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:11.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:50:0) after 1m0s
[16:42:11.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:50:0)
[16:42:11.212] Timer tick, asking Buildbucket for the build status
[16:42:12.427] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:12.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:51:0) after 1m0s
[16:43:12.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:51:0)
[16:43:12.450] Timer tick, asking Buildbucket for the build status
[16:43:13.587] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:13.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:52:0) after 1m0s
[16:44:13.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:52:0)
[16:44:13.579] Timer tick, asking Buildbucket for the build status
[16:44:13.716] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:13.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:53:0) after 1m0s
[16:45:13.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:53:0)
[16:45:13.718] Timer tick, asking Buildbucket for the build status
[16:45:14.694] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:14.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:54:0) after 1m0s
[16:46:14.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:54:0)
[16:46:14.716] Timer tick, asking Buildbucket for the build status
[16:46:15.280] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:15.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:55:0) after 1m0s
[16:47:15.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:55:0)
[16:47:15.304] Timer tick, asking Buildbucket for the build status
[16:47:15.565] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:15.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:56:0) after 1m0s
[16:48:15.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:56:0)
[16:48:15.584] Timer tick, asking Buildbucket for the build status
[16:48:15.958] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:15.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:57:0) after 1m0s
[16:49:15.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:57:0)
[16:49:15.983] Timer tick, asking Buildbucket for the build status
[16:49:16.423] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:16.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:58:0) after 1m0s
[16:50:16.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:58:0)
[16:50:16.417] Timer tick, asking Buildbucket for the build status
[16:50:16.809] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:16.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:59:0) after 1m0s
[16:51:16.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:59:0)
[16:51:16.870] Timer tick, asking Buildbucket for the build status
[16:51:17.203] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:17.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:60:0) after 1m0s
[16:52:17.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:60:0)
[16:52:17.215] Timer tick, asking Buildbucket for the build status
[16:52:18.555] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:18.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:61:0) after 1m0s
[16:53:18.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:61:0)
[16:53:18.574] Timer tick, asking Buildbucket for the build status
[16:53:19.078] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:19.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:62:0) after 1m0s
[16:54:19.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:62:0)
[16:54:19.078] Timer tick, asking Buildbucket for the build status
[16:54:19.274] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:19.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:63:0) after 1m0s
[16:55:19.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:63:0)
[16:55:19.247] Timer tick, asking Buildbucket for the build status
[16:55:19.355] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:19.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:64:0) after 1m0s
[16:56:19.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:64:0)
[16:56:19.382] Timer tick, asking Buildbucket for the build status
[16:56:19.685] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:19.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:65:0) after 1m0s
[16:57:19.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:65:0)
[16:57:19.696] Timer tick, asking Buildbucket for the build status
[16:57:20.172] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:20.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:66:0) after 1m0s
[16:58:20.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:66:0)
[16:58:20.179] Timer tick, asking Buildbucket for the build status
[16:58:21.488] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:21.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:67:0) after 1m0s
[16:59:21.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:67:0)
[16:59:21.460] Timer tick, asking Buildbucket for the build status
[16:59:21.626] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:21.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:68:0) after 1m0s
[17:00:21.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:68:0)
[17:00:21.634] Timer tick, asking Buildbucket for the build status
[17:00:23.470] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:23.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:69:0) after 1m0s
[17:01:23.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:69:0)
[17:01:23.522] Timer tick, asking Buildbucket for the build status
[17:01:23.874] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:23.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:70:0) after 1m0s
[17:02:23.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:70:0)
[17:02:23.909] Timer tick, asking Buildbucket for the build status
[17:02:24.114] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:24.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:71:0) after 1m0s
[17:03:24.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:71:0)
[17:03:24.119] Timer tick, asking Buildbucket for the build status
[17:03:24.278] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:24.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:72:0) after 1m0s
[17:04:24.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:72:0)
[17:04:24.313] Timer tick, asking Buildbucket for the build status
[17:04:24.983] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:24.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:73:0) after 1m0s
[17:05:25.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:73:0)
[17:05:25.009] Timer tick, asking Buildbucket for the build status
[17:05:25.299] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:25.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:74:0) after 1m0s
[17:06:25.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:74:0)
[17:06:25.324] Timer tick, asking Buildbucket for the build status
[17:06:25.451] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:25.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:75:0) after 1m0s
[17:07:25.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:75:0)
[17:07:25.450] Timer tick, asking Buildbucket for the build status
[17:07:25.621] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:25.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:76:0) after 1m0s
[17:08:25.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:76:0)
[17:08:25.629] Timer tick, asking Buildbucket for the build status
[17:08:25.783] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:25.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:77:0) after 1m0s
[17:09:25.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:77:0)
[17:09:25.800] Timer tick, asking Buildbucket for the build status
[17:09:26.215] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:26.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:78:0) after 1m0s
[17:10:26.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:78:0)
[17:10:26.236] Timer tick, asking Buildbucket for the build status
[17:10:26.387] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:26.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:79:0) after 1m0s
[17:11:26.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:79:0)
[17:11:26.377] Timer tick, asking Buildbucket for the build status
[17:11:26.539] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:26.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:80:0) after 1m0s
[17:12:26.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:80:0)
[17:12:26.551] Timer tick, asking Buildbucket for the build status
[17:12:27.300] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:27.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:81:0) after 1m0s
[17:13:27.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:81:0)
[17:13:27.316] Timer tick, asking Buildbucket for the build status
[17:13:28.192] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:28.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:82:0) after 1m0s
[17:14:28.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:82:0)
[17:14:28.200] Timer tick, asking Buildbucket for the build status
[17:14:28.729] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:28.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:83:0) after 1m0s
[17:15:28.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:83:0)
[17:15:28.728] Timer tick, asking Buildbucket for the build status
[17:15:29.295] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:29.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:84:0) after 1m0s
[17:16:29.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:84:0)
[17:16:29.318] Timer tick, asking Buildbucket for the build status
[17:16:29.466] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:29.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:85:0) after 1m0s
[17:17:29.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:85:0)
[17:17:29.507] Timer tick, asking Buildbucket for the build status
[17:17:29.616] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:29.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:86:0) after 1m0s
[17:18:29.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:86:0)
[17:18:29.674] Timer tick, asking Buildbucket for the build status
[17:18:31.111] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:31.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:87:0) after 1m0s
[17:19:31.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:87:0)
[17:19:31.137] Timer tick, asking Buildbucket for the build status
[17:19:31.415] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:31.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:88:0) after 1m0s
[17:20:31.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:88:0)
[17:20:31.469] Timer tick, asking Buildbucket for the build status
[17:20:31.819] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:31.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:89:0) after 1m0s
[17:21:31.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:89:0)
[17:21:31.878] Timer tick, asking Buildbucket for the build status
[17:21:32.291] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:32.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:90:0) after 1m0s
[17:22:32.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:90:0)
[17:22:32.318] Timer tick, asking Buildbucket for the build status
[17:22:33.532] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:33.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:91:0) after 1m0s
[17:23:33.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:91:0)
[17:23:33.554] Timer tick, asking Buildbucket for the build status
[17:23:33.867] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:33.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:92:0) after 1m0s
[17:24:33.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:92:0)
[17:24:33.870] Timer tick, asking Buildbucket for the build status
[17:24:34.786] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:34.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:93:0) after 1m0s
[17:25:34.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:93:0)
[17:25:34.764] Timer tick, asking Buildbucket for the build status
[17:25:34.917] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:34.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:94:0) after 1m0s
[17:26:34.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:94:0)
[17:26:34.901] Timer tick, asking Buildbucket for the build status
[17:26:35.133] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:35.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:95:0) after 1m0s
[17:27:35.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:95:0)
[17:27:35.204] Timer tick, asking Buildbucket for the build status
[17:27:35.349] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:35.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:96:0) after 1m0s
[17:28:35.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:96:0)
[17:28:35.343] Timer tick, asking Buildbucket for the build status
[17:28:35.473] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:35.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:97:0) after 1m0s
[17:29:35.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:97:0)
[17:29:35.491] Timer tick, asking Buildbucket for the build status
[17:29:36.009] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:36.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:98:0) after 1m0s
[17:30:36.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:98:0)
[17:30:36.041] Timer tick, asking Buildbucket for the build status
[17:30:36.206] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:36.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:99:0) after 1m0s
[17:31:36.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:99:0)
[17:31:36.249] Timer tick, asking Buildbucket for the build status
[17:31:37.001] Build 8914648171043927488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:37.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9080078233129655584:100:0) after 1m0s
[17:31:38.831] Received PubSub notification, asking Buildbucket for the build status
[17:31:39.153] Build 8914648171043927488: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:31:39.153] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1556731897788041",
"created_by": "project:chromium",
"created_ts": "1556726021685981",
"id": "8914648171043927488",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b893403b98970aec21b5e67c25c16edac9ccf92f\"}}",
"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\": 12159, \"got_angle_revision\": \"0f861bd8c46f7ae179c425a3be861b1bb8414dd2\", \"got_dawn_revision\": \"cc141797dfc8fd0d10eafb96c9bfab7b341b8bd4\", \"got_nacl_revision\": \"6abc006f6760ec49350cd45e8bccbff4809725ac\", \"got_revision\": \"b893403b98970aec21b5e67c25c16edac9ccf92f\", \"got_revision_cp\": \"refs/heads/master@{#655617}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"c77ce38099096de1347aa59f9d5b93191bf4b4f4\", \"got_v8_revision_cp\": \"refs/heads/7.6.79@{#1}\", \"got_webrtc_revision\": \"2bb3e4315d8732b612dcac5f42b34c3f4261ef08\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27813}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b893403b98970aec21b5e67c25c16edac9ccf92f\", \"swarm_hashes\": {\"accessibility_unittests\": \"655e378088e503fb3b4d3856e3c5f48adb25d997\", \"angle_unittests\": \"8d80fa750761e17eea4cd7aa5da8a396781e2cbf\", \"app_list_unittests\": \"2786b782f02b0095513bd44fe34a44a5c3a21982\", \"app_shell_unittests\": \"cb8d651040a9cb21a4099f92b589cbaec04634cf\", \"ash_unittests\": \"177090924b594676175a9d963a2c63e3f0dd58c2\", \"aura_unittests\": \"5548016c4492d5f95a07b0196b3255e448b7ccd7\", \"base_unittests\": \"e7d9f13f8378d780e6bc6338808dd5e507498d36\", \"blink_common_unittests\": \"ed21e71010f7abb95326e147403d7688d8d71059\", \"blink_fuzzer_unittests\": \"d594ec5affa4ff7c9c5f2654fefa35ff91fa706d\", \"blink_heap_unittests\": \"67c41709249702387895bca735133e97a45a65ab\", \"blink_platform_unittests\": \"97747f6b8c696373c27a63f67bbab51948c874b6\", \"blink_unittests\": \"0d0dba9431b711379992e6765c42cc5f14a3a900\", \"boringssl_crypto_tests\": \"f7d991f815f99ed024735f39f58b60d266fce7e2\", \"boringssl_ssl_tests\": \"ff57ba8c37298d32d64fee318faabd5478a2ab89\", \"browser_tests\": \"1f2086317871399370dd3e0f54824870a88a4d65\", \"cacheinvalidation_unittests\": \"5956c5401f7956a1ee03543e01f0f23a7fc3622d\", \"capture_unittests\": \"7e3ef53948bc66752ff364e863f62f6f04867c5a\", \"cast_unittests\": \"7b917311a61cfb8ad3fc17de89120f459d02231c\", \"cc_unittests\": \"989ae16fc9e7a31e0801f74fe2a633dd71b68aaf\", \"chrome_app_unittests\": \"4f59d7d65d0efadddadc9b2b17e1c097789d70ca\", \"chromedriver_unittests\": \"73e9f376cf3db020de40d8ca63ccd422d60536dd\", \"chromeos_components_unittests\": \"9f5ca9b1fa25ba9cfd4811f182cdac490541182c\", \"chromeos_unittests\": \"8cee3f8e2abeb9830ae150d53878d35b4770c176\", \"components_browsertests\": \"8d5e13a99f26fb521416c07ecab045ab80c219bd\", \"components_unittests\": \"a9aa31e21e5fd01f4d1345ec6babddb4e14cd06b\", \"compositor_unittests\": \"7d399b0b2c718187237742cf5bf4a858ad677c4d\", \"content_browsertests\": \"ab75d308dadd1a278ad00a662613d9e89b795fe2\", \"content_unittests\": \"1b7de43799b684f56013e91fa8c58e8898bcce74\", \"crypto_unittests\": \"76a626bd4ea938e73c232ef2d827cbee0f389939\", \"dbus_unittests\": \"7629aa4d3aa074e250b9f9dd34906535f5792af8\", \"device_unittests\": \"195411f11e4f0cf418e7d7aba189d59a5af05ba0\", \"display_unittests\": \"d4855f0b7dd54f821676a377aae2bc9d8e3ba46a\", \"events_unittests\": \"d1ca70a7797be93456acab7ff0ff273d51422a86\", \"exo_unittests\": \"8ca839446ca433d8ffa813f01ace0558062c1019\", \"extensions_browsertests\": \"7e73662b306bbe968d4b322572a222472bee7883\", \"extensions_unittests\": \"c947aa9fdabb1f49edef5a358e72881b723377ff\", \"filesystem_service_unittests\": \"b539b6c697c931376931ad74887ce3cebe3cefdc\", \"gcm_unit_tests\": \"b4c124a8c73e09694884e59efb66298ad70dc35c\", \"gfx_unittests\": \"53817d9c997e6a699c1129e5f88b585747bab8ec\", \"gin_unittests\": \"7f5bcbba5ef9890f7074ad47231832539f361c1d\", \"gl_unittests_ozone\": \"7517d42a52337983c52f9f45cbf351b42f1f79cf\", \"google_apis_unittests\": \"824c39bd214928cceaace646e8ac254e62651268\", \"gpu_unittests\": \"0f222fc2868db63df40126c50384b6c956d5095b\", \"interactive_ui_tests\": \"5e0106c15f4bfa71e665c23dc3752b31428536b3\", \"ipc_tests\": \"bf0cbafa8f40379f1e3f7702fbef760fca0ec3a7\", \"jingle_unittests\": \"01dc0022a2ed08a8dcac2fd252705f98061af5e7\", \"keyboard_unittests\": \"f9f968f656ff48bd033e619e3882f345b882e5d8\", \"latency_unittests\": \"2deba0490380822ed6858687626855b778b95998\", \"leveldb_service_unittests\": \"880f6a25666d6b9ac7fb70801cfce7695fe8bb89\", \"libjingle_xmpp_unittests\": \"5a8145fbc4585268b4af0452c365b70fb1749ddc\", \"media_blink_unittests\": \"4f5282962fd1d8145536f22dfd2e8a12fe1f5c5a\", \"media_service_unittests\": \"69029af137c3fac08ca8ba24c0a875b37bde5812\", \"media_unittests\": \"a08ed042ab5aba082acfa795820b45a348b466b5\", \"message_center_unittests\": \"799c6718ded55d04265e355f248948cbd499bfb8\", \"midi_unittests\": \"610bd50238574f1bdb1feaa7a2f0369b706b94ed\", \"mojo_core_unittests\": \"c589cb6f809347bc54c703cd5f3e274b115949bd\", \"mojo_unittests\": \"9c1c243b422f9827aeff7acaf7aff9a73e4f8b31\", \"nacl_helper_nonsfi_unittests\": \"f083e318560ca180a676416de17cbf3282968d36\", \"nacl_loader_unittests\": \"87abb3648168d0819ac6e2acc8bc06ec5ee5c2c0\", \"native_theme_unittests\": \"a5a2e87d6314e46ffcd13c9b71a184b6a824c809\", \"net_unittests\": \"6c3ab38114c14f8682022c75083c44e6f31f9a6f\", \"ozone_gl_unittests\": \"a92e4d8beb9c4472c8b7a228c10ea4f8ed9bb819\", \"ozone_unittests\": \"c6903bbff50d01b87200a1dd086bf8c263b6d822\", \"ozone_x11_unittests\": \"7b792e31af5d5ea724f6515573e6df4bec75f434\", \"pdf_unittests\": \"dcc51b2f80a26891288150d5d2ee50648fe33bc3\", \"perfetto_unittests\": \"5031860fb130dfdcd25f6711971a4501dc2294e2\", \"ppapi_unittests\": \"b7bd34048a680e14f3376c50d2c78ffe34df2b5e\", \"printing_unittests\": \"26eb20252867e8cfe8c932fec87681b989ec84a5\", \"remoting_unittests\": \"b1a1ae54002fb6e7ea833e9163642e18585c52a6\", \"sandbox_linux_unittests\": \"3a852c1539ca6eafcf43af2574d15bcc55f0bdb6\", \"service_manager_unittests\": \"3aaa4119dafe7be3e69755fd40b0fbdc3b9e4ffc\", \"services_unittests\": \"9d863c73486ba8fce30e4a0c87a99e75e78f9c27\", \"shell_dialogs_unittests\": \"f2e2e2c1b8f042808f321bb670d92527bc099a66\", \"skia_unittests\": \"3df5e8fed172fab7413549687e0154c5d58da848\", \"snapshot_unittests\": \"04cebe74e4a8da02137b4b376c6337e1282ba307\", \"sql_unittests\": \"62864cfc4ef2d28a87dfef1803e1a10181ed166b\", \"storage_unittests\": \"15ae1e9a21deaf2265a9d3735fe181bec6aa2221\", \"sync_integration_tests\": \"e01fcb90049c744be0bc91fc35e20cbe1765691a\", \"traffic_annotation_auditor_unittests\": \"ab8c79262ad64c34823a9841259b7dc047d35f6b\", \"ui_base_unittests\": \"cca1bb19d74611d1b4a217d5bee48f31453c1de1\", \"ui_chromeos_unittests\": \"e75dee9677d9d30bfdf91ed6a8cf4c3784710de1\", \"ui_touch_selection_unittests\": \"adfc220984909473621e01940d5288fbf903b5b1\", \"unit_tests\": \"88c10002ef9982a9e8bfd47995890075a8fb2fd5\", \"url_unittests\": \"ada3aea354b4f8c7619941bc3673bf0f6f5fbd14\", \"usage_time_limit_unittests\": \"c05acb9a06465e834e74bf967a32e2d723ab3db6\", \"views_unittests\": \"d70806d1b565bd89d21c713e9ff29c80459882f6\", \"viz_unittests\": \"2563e75b5b7c0d253da2e61f1f6e9a79811286e6\", \"wm_unittests\": \"5e4a09e062cc49ea5e441a73fba7d400f7f987da\", \"wtf_unittests\": \"15c1934306f9f912c9b083c71276b2e0c0b7f0ce\"}, \"swarm_hashes_refs/heads/master(at){#655617}_without_patch\": {\"accessibility_unittests\": \"655e378088e503fb3b4d3856e3c5f48adb25d997\", \"angle_unittests\": \"8d80fa750761e17eea4cd7aa5da8a396781e2cbf\", \"app_list_unittests\": \"2786b782f02b0095513bd44fe34a44a5c3a21982\", \"app_shell_unittests\": \"cb8d651040a9cb21a4099f92b589cbaec04634cf\", \"ash_unittests\": \"177090924b594676175a9d963a2c63e3f0dd58c2\", \"aura_unittests\": \"5548016c4492d5f95a07b0196b3255e448b7ccd7\", \"base_unittests\": \"e7d9f13f8378d780e6bc6338808dd5e507498d36\", \"blink_common_unittests\": \"ed21e71010f7abb95326e147403d7688d8d71059\", \"blink_fuzzer_unittests\": \"d594ec5affa4ff7c9c5f2654fefa35ff91fa706d\", \"blink_heap_unittests\": \"67c41709249702387895bca735133e97a45a65ab\", \"blink_platform_unittests\": \"97747f6b8c696373c27a63f67bbab51948c874b6\", \"blink_unittests\": \"0d0dba9431b711379992e6765c42cc5f14a3a900\", \"boringssl_crypto_tests\": \"f7d991f815f99ed024735f39f58b60d266fce7e2\", \"boringssl_ssl_tests\": \"ff57ba8c37298d32d64fee318faabd5478a2ab89\", \"browser_tests\": \"1f2086317871399370dd3e0f54824870a88a4d65\", \"cacheinvalidation_unittests\": \"5956c5401f7956a1ee03543e01f0f23a7fc3622d\", \"capture_unittests\": \"7e3ef53948bc66752ff364e863f62f6f04867c5a\", \"cast_unittests\": \"7b917311a61cfb8ad3fc17de89120f459d02231c\", \"cc_unittests\": \"989ae16fc9e7a31e0801f74fe2a633dd71b68aaf\", \"chrome_app_unittests\": \"4f59d7d65d0efadddadc9b2b17e1c097789d70ca\", \"chromedriver_unittests\": \"73e9f376cf3db020de40d8ca63ccd422d60536dd\", \"chromeos_components_unittests\": \"9f5ca9b1fa25ba9cfd4811f182cdac490541182c\", \"chromeos_unittests\": \"8cee3f8e2abeb9830ae150d53878d35b4770c176\", \"components_browsertests\": \"8d5e13a99f26fb521416c07ecab045ab80c219bd\", \"components_unittests\": \"a9aa31e21e5fd01f4d1345ec6babddb4e14cd06b\", \"compositor_unittests\": \"7d399b0b2c718187237742cf5bf4a858ad677c4d\", \"content_browsertests\": \"ab75d308dadd1a278ad00a662613d9e89b795fe2\", \"content_unittests\": \"1b7de43799b684f56013e91fa8c58e8898bcce74\", \"crypto_unittests\": \"76a626bd4ea938e73c232ef2d827cbee0f389939\", \"dbus_unittests\": \"7629aa4d3aa074e250b9f9dd34906535f5792af8\", \"device_unittests\": \"195411f11e4f0cf418e7d7aba189d59a5af05ba0\", \"display_unittests\": \"d4855f0b7dd54f821676a377aae2bc9d8e3ba46a\", \"events_unittests\": \"d1ca70a7797be93456acab7ff0ff273d51422a86\", \"exo_unittests\": \"8ca839446ca433d8ffa813f01ace0558062c1019\", \"extensions_browsertests\": \"7e73662b306bbe968d4b322572a222472bee7883\", \"extensions_unittests\": \"c947aa9fdabb1f49edef5a358e72881b723377ff\", \"filesystem_service_unittests\": \"b539b6c697c931376931ad74887ce3cebe3cefdc\", \"gcm_unit_tests\": \"b4c124a8c73e09694884e59efb66298ad70dc35c\", \"gfx_unittests\": \"53817d9c997e6a699c1129e5f88b585747bab8ec\", \"gin_unittests\": \"7f5bcbba5ef9890f7074ad47231832539f361c1d\", \"gl_unittests_ozone\": \"7517d42a52337983c52f9f45cbf351b42f1f79cf\", \"google_apis_unittests\": \"824c39bd214928cceaace646e8ac254e62651268\", \"gpu_unittests\": \"0f222fc2868db63df40126c50384b6c956d5095b\", \"interactive_ui_tests\": \"5e0106c15f4bfa71e665c23dc3752b31428536b3\", \"ipc_tests\": \"bf0cbafa8f40379f1e3f7702fbef760fca0ec3a7\", \"jingle_unittests\": \"01dc0022a2ed08a8dcac2fd252705f98061af5e7\", \"keyboard_unittests\": \"f9f968f656ff48bd033e619e3882f345b882e5d8\", \"latency_unittests\": \"2deba0490380822ed6858687626855b778b95998\", \"leveldb_service_unittests\": \"880f6a25666d6b9ac7fb70801cfce7695fe8bb89\", \"libjingle_xmpp_unittests\": \"5a8145fbc4585268b4af0452c365b70fb1749ddc\", \"media_blink_unittests\": \"4f5282962fd1d8145536f22dfd2e8a12fe1f5c5a\", \"media_service_unittests\": \"69029af137c3fac08ca8ba24c0a875b37bde5812\", \"media_unittests\": \"a08ed042ab5aba082acfa795820b45a348b466b5\", \"message_center_unittests\": \"799c6718ded55d04265e355f248948cbd499bfb8\", \"midi_unittests\": \"610bd50238574f1bdb1feaa7a2f0369b706b94ed\", \"mojo_core_unittests\": \"c589cb6f809347bc54c703cd5f3e274b115949bd\", \"mojo_unittests\": \"9c1c243b422f9827aeff7acaf7aff9a73e4f8b31\", \"nacl_helper_nonsfi_unittests\": \"f083e318560ca180a676416de17cbf3282968d36\", \"nacl_loader_unittests\": \"87abb3648168d0819ac6e2acc8bc06ec5ee5c2c0\", \"native_theme_unittests\": \"a5a2e87d6314e46ffcd13c9b71a184b6a824c809\", \"net_unittests\": \"6c3ab38114c14f8682022c75083c44e6f31f9a6f\", \"ozone_gl_unittests\": \"a92e4d8beb9c4472c8b7a228c10ea4f8ed9bb819\", \"ozone_unittests\": \"c6903bbff50d01b87200a1dd086bf8c263b6d822\", \"ozone_x11_unittests\": \"7b792e31af5d5ea724f6515573e6df4bec75f434\", \"pdf_unittests\": \"dcc51b2f80a26891288150d5d2ee50648fe33bc3\", \"perfetto_unittests\": \"5031860fb130dfdcd25f6711971a4501dc2294e2\", \"ppapi_unittests\": \"b7bd34048a680e14f3376c50d2c78ffe34df2b5e\", \"printing_unittests\": \"26eb20252867e8cfe8c932fec87681b989ec84a5\", \"remoting_unittests\": \"b1a1ae54002fb6e7ea833e9163642e18585c52a6\", \"sandbox_linux_unittests\": \"3a852c1539ca6eafcf43af2574d15bcc55f0bdb6\", \"service_manager_unittests\": \"3aaa4119dafe7be3e69755fd40b0fbdc3b9e4ffc\", \"services_unittests\": \"9d863c73486ba8fce30e4a0c87a99e75e78f9c27\", \"shell_dialogs_unittests\": \"f2e2e2c1b8f042808f321bb670d92527bc099a66\", \"skia_unittests\": \"3df5e8fed172fab7413549687e0154c5d58da848\", \"snapshot_unittests\": \"04cebe74e4a8da02137b4b376c6337e1282ba307\", \"sql_unittests\": \"62864cfc4ef2d28a87dfef1803e1a10181ed166b\", \"storage_unittests\": \"15ae1e9a21deaf2265a9d3735fe181bec6aa2221\", \"sync_integration_tests\": \"e01fcb90049c744be0bc91fc35e20cbe1765691a\", \"traffic_annotation_auditor_unittests\": \"ab8c79262ad64c34823a9841259b7dc047d35f6b\", \"ui_base_unittests\": \"cca1bb19d74611d1b4a217d5bee48f31453c1de1\", \"ui_chromeos_unittests\": \"e75dee9677d9d30bfdf91ed6a8cf4c3784710de1\", \"ui_touch_selection_unittests\": \"adfc220984909473621e01940d5288fbf903b5b1\", \"unit_tests\": \"88c10002ef9982a9e8bfd47995890075a8fb2fd5\", \"url_unittests\": \"ada3aea354b4f8c7619941bc3673bf0f6f5fbd14\", \"usage_time_limit_unittests\": \"c05acb9a06465e834e74bf967a32e2d723ab3db6\", \"views_unittests\": \"d70806d1b565bd89d21c713e9ff29c80459882f6\", \"viz_unittests\": \"2563e75b5b7c0d253da2e61f1f6e9a79811286e6\", \"wm_unittests\": \"5e4a09e062cc49ea5e441a73fba7d400f7f987da\", \"wtf_unittests\": \"15c1934306f9f912c9b083c71276b2e0c0b7f0ce\"}}, \"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\": [\"4277-e1590cf\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1556726024038456",
"status": "COMPLETED",
"status_changed_ts": "1556731898259077",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12159",
"builder:linux-chromeos-dbg",
"buildset:commit/git/b893403b98970aec21b5e67c25c16edac9ccf92f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b893403b98970aec21b5e67c25c16edac9ccf92f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080078233129655584",
"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/8914648171043927488/+/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:448ceb8a63862810",
"user_agent:luci-scheduler"
],
"updated_ts": "1556731898268366",
"url": "https://ci.chromium.org/b/8914648171043927488",
"utcnow_ts": "1556731899141785"
}
}
[17:31:39.153] Invocation finished in 1h37m58.840884635s with status SUCCEEDED