[02:18:26.107] New invocation is queued and will start shortly
[02:18:27.134] Starting the invocation (attempt 1)
[02:18:27.166] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:18:27.166] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:18:27.166] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9083209820270519440",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"579a7ac901b959771acf2881e2c8643c4c737d24\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9083209820270519440",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/579a7ac901b959771acf2881e2c8643c4c737d24",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/579a7ac901b959771acf2881e2c8643c4c737d24",
"gitiles_ref:refs/heads/master"
]
}
[02:18:27.998] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1553739507334515",
"id": "8917779758315859344",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"579a7ac901b959771acf2881e2c8643c4c737d24\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553739507797324",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11576",
"builder:linux-chromeos-dbg",
"buildset:commit/git/579a7ac901b959771acf2881e2c8643c4c737d24",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/579a7ac901b959771acf2881e2c8643c4c737d24",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083209820270519440",
"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/8917779758315859344/+/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": "1553739507797437",
"url": "https://ci.chromium.org/b/8917779758315859344",
"utcnow_ts": "1553739507983719"
}
}
[02:18:27.998] Task URL: https://ci.chromium.org/b/8917779758315859344
[02:18:27.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:2:0) after 1m0s
[02:19:28.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:2:0)
[02:19:28.010] Timer tick, asking Buildbucket for the build status
[02:19:28.200] Build 8917779758315859344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:28.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:3:0) after 1m0s
[02:20:28.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:3:0)
[02:20:28.251] Timer tick, asking Buildbucket for the build status
[02:20:28.734] Build 8917779758315859344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:28.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:4:0) after 1m0s
[02:21:28.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:4:0)
[02:21:28.722] Timer tick, asking Buildbucket for the build status
[02:21:28.833] Build 8917779758315859344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:28.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:5:0) after 1m0s
[02:22:28.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:5:0)
[02:22:28.853] Timer tick, asking Buildbucket for the build status
[02:22:29.028] Build 8917779758315859344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:29.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:6:0) after 1m0s
[02:23:29.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:6:0)
[02:23:29.049] Timer tick, asking Buildbucket for the build status
[02:23:29.167] Build 8917779758315859344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:29.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:7:0) after 1m0s
[02:24:29.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:7:0)
[02:24:29.189] Timer tick, asking Buildbucket for the build status
[02:24:29.305] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:29.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:8:0) after 1m0s
[02:24:30.815] Received PubSub notification, asking Buildbucket for the build status
[02:24:30.995] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:29.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:8:0)
[02:25:29.321] Timer tick, asking Buildbucket for the build status
[02:25:29.443] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:29.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:10:0) after 1m0s
[02:26:29.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:10:0)
[02:26:29.453] Timer tick, asking Buildbucket for the build status
[02:26:29.695] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:29.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:11:0) after 1m0s
[02:27:29.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:11:0)
[02:27:29.714] Timer tick, asking Buildbucket for the build status
[02:27:29.870] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:29.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:12:0) after 1m0s
[02:28:29.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:12:0)
[02:28:29.884] Timer tick, asking Buildbucket for the build status
[02:28:29.986] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:29.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:13:0) after 1m0s
[02:29:30.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:13:0)
[02:29:30.010] Timer tick, asking Buildbucket for the build status
[02:29:30.162] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:30.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:14:0) after 1m0s
[02:30:30.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:14:0)
[02:30:30.188] Timer tick, asking Buildbucket for the build status
[02:30:30.307] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:30.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:15:0) after 1m0s
[02:31:30.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:15:0)
[02:31:30.325] Timer tick, asking Buildbucket for the build status
[02:31:30.444] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:30.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:16:0) after 1m0s
[02:32:30.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:16:0)
[02:32:30.437] Timer tick, asking Buildbucket for the build status
[02:32:30.801] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:30.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:17:0) after 1m0s
[02:33:30.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:17:0)
[02:33:30.832] Timer tick, asking Buildbucket for the build status
[02:33:30.920] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:30.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:18:0) after 1m0s
[02:34:30.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:18:0)
[02:34:30.946] Timer tick, asking Buildbucket for the build status
[02:34:31.537] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:31.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:19:0) after 1m0s
[02:35:31.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:19:0)
[02:35:31.558] Timer tick, asking Buildbucket for the build status
[02:35:32.150] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:32.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:20:0) after 1m0s
[02:36:32.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:20:0)
[02:36:32.155] Timer tick, asking Buildbucket for the build status
[02:36:33.056] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:33.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:21:0) after 1m0s
[02:37:33.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:21:0)
[02:37:33.067] Timer tick, asking Buildbucket for the build status
[02:37:33.793] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:33.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:22:0) after 1m0s
[02:38:33.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:22:0)
[02:38:33.816] Timer tick, asking Buildbucket for the build status
[02:38:34.148] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:34.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:23:0) after 1m0s
[02:39:34.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:23:0)
[02:39:34.176] Timer tick, asking Buildbucket for the build status
[02:39:34.319] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:34.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:24:0) after 1m0s
[02:40:34.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:24:0)
[02:40:34.342] Timer tick, asking Buildbucket for the build status
[02:40:34.431] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:34.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:25:0) after 1m0s
[02:41:34.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:25:0)
[02:41:34.451] Timer tick, asking Buildbucket for the build status
[02:41:34.575] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:34.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:26:0) after 1m0s
[02:42:34.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:26:0)
[02:42:34.560] Timer tick, asking Buildbucket for the build status
[02:42:34.816] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:34.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:27:0) after 1m0s
[02:43:34.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:27:0)
[02:43:34.811] Timer tick, asking Buildbucket for the build status
[02:43:34.896] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:34.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:28:0) after 1m0s
[02:44:34.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:28:0)
[02:44:34.909] Timer tick, asking Buildbucket for the build status
[02:44:35.027] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:35.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:29:0) after 1m0s
[02:45:35.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:29:0)
[02:45:35.036] Timer tick, asking Buildbucket for the build status
[02:45:35.368] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:35.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:30:0) after 1m0s
[02:46:35.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:30:0)
[02:46:35.389] Timer tick, asking Buildbucket for the build status
[02:46:35.503] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:35.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:31:0) after 1m0s
[02:47:35.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:31:0)
[02:47:35.477] Timer tick, asking Buildbucket for the build status
[02:47:35.663] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:35.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:32:0) after 1m0s
[02:48:35.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:32:0)
[02:48:35.688] Timer tick, asking Buildbucket for the build status
[02:48:35.894] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:35.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:33:0) after 1m0s
[02:49:35.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:33:0)
[02:49:35.915] Timer tick, asking Buildbucket for the build status
[02:49:36.105] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:36.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:34:0) after 1m0s
[02:50:36.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:34:0)
[02:50:36.124] Timer tick, asking Buildbucket for the build status
[02:50:36.568] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:36.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:35:0) after 1m0s
[02:51:36.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:35:0)
[02:51:36.589] Timer tick, asking Buildbucket for the build status
[02:51:37.154] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:37.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:36:0) after 1m0s
[02:52:37.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:36:0)
[02:52:37.175] Timer tick, asking Buildbucket for the build status
[02:52:38.014] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:38.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:37:0) after 1m0s
[02:53:37.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:37:0)
[02:53:37.996] Timer tick, asking Buildbucket for the build status
[02:53:38.463] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:38.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:38:0) after 1m0s
[02:54:38.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:38:0)
[02:54:38.490] Timer tick, asking Buildbucket for the build status
[02:54:38.651] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:38.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:39:0) after 1m0s
[02:55:38.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:39:0)
[02:55:38.675] Timer tick, asking Buildbucket for the build status
[02:55:39.272] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:39.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:40:0) after 1m0s
[02:56:39.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:40:0)
[02:56:39.323] Timer tick, asking Buildbucket for the build status
[02:56:39.444] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:39.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:41:0) after 1m0s
[02:57:39.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:41:0)
[02:57:39.464] Timer tick, asking Buildbucket for the build status
[02:57:39.617] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:39.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:42:0) after 1m0s
[02:58:39.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:42:0)
[02:58:39.662] Timer tick, asking Buildbucket for the build status
[02:58:40.001] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:40.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:43:0) after 1m0s
[02:59:40.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:43:0)
[02:59:40.031] Timer tick, asking Buildbucket for the build status
[02:59:40.176] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:40.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:44:0) after 1m0s
[03:00:40.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:44:0)
[03:00:40.196] Timer tick, asking Buildbucket for the build status
[03:00:40.405] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:40.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:45:0) after 1m0s
[03:01:40.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:45:0)
[03:01:40.430] Timer tick, asking Buildbucket for the build status
[03:01:41.100] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:41.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:46:0) after 1m0s
[03:02:41.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:46:0)
[03:02:41.122] Timer tick, asking Buildbucket for the build status
[03:02:41.246] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:41.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:47:0) after 1m0s
[03:03:41.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:47:0)
[03:03:41.285] Timer tick, asking Buildbucket for the build status
[03:03:41.508] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:41.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:48:0) after 1m0s
[03:04:41.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:48:0)
[03:04:41.529] Timer tick, asking Buildbucket for the build status
[03:04:41.639] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:41.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:49:0) after 1m0s
[03:05:41.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:49:0)
[03:05:41.713] Timer tick, asking Buildbucket for the build status
[03:05:42.029] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:42.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:50:0) after 1m0s
[03:06:42.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:50:0)
[03:06:42.056] Timer tick, asking Buildbucket for the build status
[03:06:42.549] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:42.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:51:0) after 1m0s
[03:07:42.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:51:0)
[03:07:42.563] Timer tick, asking Buildbucket for the build status
[03:07:42.664] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:42.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:52:0) after 1m0s
[03:08:42.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:52:0)
[03:08:42.687] Timer tick, asking Buildbucket for the build status
[03:08:43.869] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:43.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:53:0) after 1m0s
[03:09:43.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:53:0)
[03:09:43.949] Timer tick, asking Buildbucket for the build status
[03:09:44.482] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:44.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:54:0) after 1m0s
[03:10:44.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:54:0)
[03:10:44.493] Timer tick, asking Buildbucket for the build status
[03:10:44.644] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:44.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:55:0) after 1m0s
[03:11:44.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:55:0)
[03:11:44.667] Timer tick, asking Buildbucket for the build status
[03:11:45.014] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:45.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:56:0) after 1m0s
[03:12:45.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:56:0)
[03:12:45.057] Timer tick, asking Buildbucket for the build status
[03:12:45.237] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:45.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:57:0) after 1m0s
[03:13:45.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:57:0)
[03:13:45.258] Timer tick, asking Buildbucket for the build status
[03:13:46.440] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:46.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:58:0) after 1m0s
[03:14:46.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:58:0)
[03:14:46.462] Timer tick, asking Buildbucket for the build status
[03:14:46.794] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:46.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:59:0) after 1m0s
[03:15:46.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:59:0)
[03:15:46.816] Timer tick, asking Buildbucket for the build status
[03:15:47.060] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:47.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:60:0) after 1m0s
[03:16:47.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:60:0)
[03:16:47.082] Timer tick, asking Buildbucket for the build status
[03:16:47.366] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:47.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:61:0) after 1m0s
[03:17:47.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:61:0)
[03:17:47.383] Timer tick, asking Buildbucket for the build status
[03:17:47.541] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:47.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:62:0) after 1m0s
[03:18:47.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:62:0)
[03:18:47.567] Timer tick, asking Buildbucket for the build status
[03:18:47.679] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:47.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:63:0) after 1m0s
[03:19:47.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:63:0)
[03:19:47.650] Timer tick, asking Buildbucket for the build status
[03:19:47.909] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:47.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:64:0) after 1m0s
[03:20:47.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:64:0)
[03:20:47.935] Timer tick, asking Buildbucket for the build status
[03:20:48.092] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:48.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:65:0) after 1m0s
[03:21:48.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:65:0)
[03:21:48.113] Timer tick, asking Buildbucket for the build status
[03:21:48.657] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:48.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:66:0) after 1m0s
[03:22:48.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:66:0)
[03:22:48.680] Timer tick, asking Buildbucket for the build status
[03:22:48.826] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:48.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:67:0) after 1m0s
[03:23:48.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:67:0)
[03:23:48.860] Timer tick, asking Buildbucket for the build status
[03:23:49.681] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:49.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:68:0) after 1m0s
[03:24:49.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:68:0)
[03:24:49.729] Timer tick, asking Buildbucket for the build status
[03:24:49.956] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:49.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:69:0) after 1m0s
[03:25:49.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:69:0)
[03:25:49.961] Timer tick, asking Buildbucket for the build status
[03:25:50.134] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:50.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:70:0) after 1m0s
[03:26:50.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:70:0)
[03:26:50.163] Timer tick, asking Buildbucket for the build status
[03:26:50.268] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:50.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:71:0) after 1m0s
[03:27:50.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:71:0)
[03:27:50.289] Timer tick, asking Buildbucket for the build status
[03:27:51.161] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:51.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:72:0) after 1m0s
[03:28:51.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:72:0)
[03:28:51.149] Timer tick, asking Buildbucket for the build status
[03:28:51.326] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:51.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:73:0) after 1m0s
[03:29:51.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:73:0)
[03:29:51.351] Timer tick, asking Buildbucket for the build status
[03:29:51.461] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:51.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:74:0) after 1m0s
[03:30:51.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:74:0)
[03:30:51.492] Timer tick, asking Buildbucket for the build status
[03:30:52.248] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:52.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:75:0) after 1m0s
[03:31:52.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:75:0)
[03:31:52.233] Timer tick, asking Buildbucket for the build status
[03:31:52.726] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:52.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:76:0) after 1m0s
[03:32:52.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:76:0)
[03:32:52.725] Timer tick, asking Buildbucket for the build status
[03:32:52.832] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:52.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:77:0) after 1m0s
[03:33:52.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:77:0)
[03:33:52.868] Timer tick, asking Buildbucket for the build status
[03:33:52.995] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:52.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:78:0) after 1m0s
[03:34:52.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:78:0)
[03:34:52.997] Timer tick, asking Buildbucket for the build status
[03:34:53.169] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:53.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:79:0) after 1m0s
[03:35:53.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:79:0)
[03:35:53.177] Timer tick, asking Buildbucket for the build status
[03:35:53.642] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:53.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:80:0) after 1m0s
[03:36:53.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:80:0)
[03:36:53.665] Timer tick, asking Buildbucket for the build status
[03:36:53.933] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:53.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:81:0) after 1m0s
[03:37:53.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:81:0)
[03:37:53.920] Timer tick, asking Buildbucket for the build status
[03:37:55.323] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:55.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:82:0) after 1m0s
[03:38:55.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:82:0)
[03:38:55.347] Timer tick, asking Buildbucket for the build status
[03:38:55.770] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:55.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:83:0) after 1m0s
[03:39:55.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:83:0)
[03:39:55.795] Timer tick, asking Buildbucket for the build status
[03:39:55.966] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:55.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:84:0) after 1m0s
[03:40:56.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:84:0)
[03:40:56.004] Timer tick, asking Buildbucket for the build status
[03:40:56.133] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:56.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:85:0) after 1m0s
[03:41:56.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:85:0)
[03:41:56.135] Timer tick, asking Buildbucket for the build status
[03:41:56.278] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:56.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:86:0) after 1m0s
[03:42:56.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:86:0)
[03:42:56.273] Timer tick, asking Buildbucket for the build status
[03:42:56.443] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:56.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:87:0) after 1m0s
[03:43:56.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:87:0)
[03:43:56.467] Timer tick, asking Buildbucket for the build status
[03:43:57.293] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:57.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:88:0) after 1m0s
[03:44:57.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:88:0)
[03:44:57.320] Timer tick, asking Buildbucket for the build status
[03:44:58.217] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:58.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:89:0) after 1m0s
[03:45:58.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:89:0)
[03:45:58.240] Timer tick, asking Buildbucket for the build status
[03:45:58.812] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:58.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:90:0) after 1m0s
[03:46:58.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:90:0)
[03:46:58.838] Timer tick, asking Buildbucket for the build status
[03:46:58.958] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:58.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:91:0) after 1m0s
[03:47:58.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:91:0)
[03:47:58.981] Timer tick, asking Buildbucket for the build status
[03:47:59.166] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:59.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:92:0) after 1m0s
[03:48:59.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:92:0)
[03:48:59.140] Timer tick, asking Buildbucket for the build status
[03:48:59.250] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:59.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:93:0) after 1m0s
[03:49:59.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:93:0)
[03:49:59.273] Timer tick, asking Buildbucket for the build status
[03:49:59.414] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:59.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:94:0) after 1m0s
[03:50:59.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:94:0)
[03:50:59.418] Timer tick, asking Buildbucket for the build status
[03:50:59.565] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:59.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:95:0) after 1m0s
[03:51:59.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:95:0)
[03:51:59.590] Timer tick, asking Buildbucket for the build status
[03:51:59.685] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:59.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:96:0) after 1m0s
[03:52:59.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:96:0)
[03:52:59.731] Timer tick, asking Buildbucket for the build status
[03:52:59.838] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:59.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:97:0) after 1m0s
[03:53:59.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:97:0)
[03:53:59.849] Timer tick, asking Buildbucket for the build status
[03:54:00.016] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:00.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:98:0) after 1m0s
[03:55:00.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:98:0)
[03:55:00.040] Timer tick, asking Buildbucket for the build status
[03:55:00.195] Build 8917779758315859344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:00.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083209820270519440:99:0) after 1m0s
[03:55:01.611] Received PubSub notification, asking Buildbucket for the build status
[03:55:01.872] Build 8917779758315859344: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:55:01.872] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1553745301045890",
"created_by": "project:chromium",
"created_ts": "1553739507334515",
"failure_reason": "BUILD_FAILURE",
"id": "8917779758315859344",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"579a7ac901b959771acf2881e2c8643c4c737d24\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 tests failed: ['non_network_service_browser_tests', 'non_network_service_interactive_ui_tests']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 11576, \"got_angle_revision\": \"208af3ebda25d0dcd7d7106209d17bd1532ad710\", \"got_dawn_revision\": \"889d743baa3d150e25cb2ef27b6b0366ce5b6d84\", \"got_nacl_revision\": \"de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1\", \"got_revision\": \"579a7ac901b959771acf2881e2c8643c4c737d24\", \"got_revision_cp\": \"refs/heads/master@{#645147}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"1b0ea7c9fc13c2808ca6626d8fa11c779bf08e7d\", \"got_v8_revision_cp\": \"refs/heads/7.5.128@{#1}\", \"got_webrtc_revision\": \"b3ae979ecd92180109fcf2c6c6e200b97d25d62c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27326}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"579a7ac901b959771acf2881e2c8643c4c737d24\", \"swarm_hashes\": {\"accessibility_unittests\": \"357ce5360b0b456ec4c0eb136781a54d5c0faa6c\", \"angle_unittests\": \"b7e83a0468fee2e71c83bebc5abb036a2c776cde\", \"app_list_unittests\": \"1abdbde82b57fb299ffb40cada56d323233c8a45\", \"app_shell_unittests\": \"9a12230356c3213c1edf7c0b6a6d8d0c612af8d6\", \"ash_unittests\": \"3206ee804c2814aa5d2b147fb2ae6743b323ae29\", \"aura_unittests\": \"197976ca4af9c6d4e99ce82ed3743a5ece0e5258\", \"base_unittests\": \"8cd124dbde82ece516e3dbcf58260e87269b0f6b\", \"blink_common_unittests\": \"c7b333b392120fa60c718134790cbaa0ae2c6b2a\", \"blink_fuzzer_unittests\": \"4f99c11fb90f9c6e370dea7386f22d26366a3662\", \"blink_heap_unittests\": \"480d70b420eb452f86d7ef7a9f4cb0cc79adfcee\", \"blink_platform_unittests\": \"c1f594cc12ac4f7f02830bfea193a4a706e8efc0\", \"blink_unittests\": \"e79f2d811ab568298480941110fe02aad2fcfdc8\", \"boringssl_crypto_tests\": \"114cc5aa8a379d0eef5d13d7e44d4e683de08dc5\", \"boringssl_ssl_tests\": \"294d6f00e233a5248644263a48bf2e729a4fa735\", \"browser_tests\": \"86f3a8fab1dcd78d1216a7e2ff8cc5e06591b8b7\", \"cacheinvalidation_unittests\": \"e9e9d02f07b81f41659fbd04e64e410a9a7a69e7\", \"capture_unittests\": \"ccf58cd0937f5898a0592b0d847250b266b766d8\", \"cast_unittests\": \"e3bfd36b94d9b1f4cef31a9f46c4f89fb8e8a6da\", \"cc_unittests\": \"38b16f145183496bc9829132a92ed829cabbdc23\", \"chrome_app_unittests\": \"1b8648ed05d4ea0581fd7cf2444837d9fb2205b8\", \"chromedriver_unittests\": \"2c8194df711c885078d8b1ff3f0ecc5ea75ad9ff\", \"chromeos_components_unittests\": \"696b453333a87fa932bdfce9a89ed0e903284618\", \"chromeos_unittests\": \"d037f28a7370c1f0078e163505fe4b4ee42e4bcd\", \"components_browsertests\": \"e25d266afb31816ae10e9649a13b61af535ca97d\", \"components_unittests\": \"b09b69893958b9eeb1742d127a08c5bc7e1db9fc\", \"compositor_unittests\": \"2e4cf9a839f7ccacc59366cce8d35a1d4aa507b9\", \"content_browsertests\": \"b8977907c32e2f56728440cbc865ca47bbb53f74\", \"content_unittests\": \"410c659671d9d9105f8a72b41465ee00f0b8702e\", \"crypto_unittests\": \"a37566a163967a0764f271f3e36c84cdb1ca0114\", \"dbus_unittests\": \"56567ce1b8dc1071de6713046cbc56860dfa25c9\", \"device_unittests\": \"c593a214736c12e021ad4277e21c55a6d3d84158\", \"display_unittests\": \"8ce8f1c775aa29cdf18a12588db0fcf1adf75a28\", \"events_unittests\": \"699182ac0862bd212db3360b53a2eab34d9b15a8\", \"exo_unittests\": \"4eb95f4637585860c260baba3e2726ad29a94cb9\", \"extensions_browsertests\": \"43404ff85b68b634f5d41da9840c63cbead1b27c\", \"extensions_unittests\": \"c0bd795403c6660069237ed0a4c40a4e2cc7def4\", \"filesystem_service_unittests\": \"5caf5d15da44e9646a37a63851bd99da6a14487f\", \"gcm_unit_tests\": \"8b63b0f11d38c1ec0987e517d9d223d16c266116\", \"gfx_unittests\": \"f059680206209d3184a74eef75899e281446d6ed\", \"gin_unittests\": \"897e9e7ba50dce6681fb47f474c46418437b3af6\", \"gl_unittests_ozone\": \"e399019f46a93843a2cae558bd1e778f8bce8c81\", \"google_apis_unittests\": \"2a02ec0ed6afb32e2c0f4bb5ec8d9c92b5a0f142\", \"gpu_unittests\": \"e526f8c83da46a780ee49b3b30708d66965bd999\", \"interactive_ui_tests\": \"07d3c2056fbb2be11bbf7f78978f3b3714f00e65\", \"ipc_tests\": \"628e8548b8b171a593463ce2c49a21ed50c05e44\", \"jingle_unittests\": \"4b766b9802a0722e753c8c36f88c80fbca7c25ef\", \"keyboard_unittests\": \"a93b37e58fecd65073204b2e401ee42680ed5996\", \"latency_unittests\": \"cf038ec9f010ff87f1f18781916a2603e9b26916\", \"leveldb_service_unittests\": \"37ed6df2ceb4fd72d12af000f09d7259051f252b\", \"libjingle_xmpp_unittests\": \"29932605e3226fb865102d9c5489546aaaef6d5a\", \"media_blink_unittests\": \"bb55a3039042e782b7f03d4520f14535ec42cfc3\", \"media_service_unittests\": \"993e5d30a579b4619a8459f13a3fef069e527602\", \"media_unittests\": \"53d3c6a8328fccf0428075d8f9f6c4c1eb857837\", \"message_center_unittests\": \"a31647d88c1726edbf35efa1073c0f49c3b3e773\", \"midi_unittests\": \"953de307de9cc72d24a9578cebee469a45ea7021\", \"mojo_core_unittests\": \"db347681f0aaf25ea07dc3979de65af08bae58b1\", \"mojo_unittests\": \"e01ec75d37c1aa601670439550f706b0f343eda2\", \"nacl_helper_nonsfi_unittests\": \"4d0ea0e128624ed500045b530f2711be15548ace\", \"nacl_loader_unittests\": \"c8f5cc43c9068f8ae4b7c8a4632aef629675f496\", \"native_theme_unittests\": \"acb836c6c099a52517d49b76344d8a8b2ecae5ff\", \"net_unittests\": \"d9fb8b313e309e2ab982f02883bc7729b1cebd94\", \"ozone_gl_unittests\": \"4dfe6e1058aab34a397bf4292e0a87ef0576f54f\", \"ozone_unittests\": \"0f11b9567acfba25e32585a0dd80c29c3d85b0fd\", \"ozone_x11_unittests\": \"fd32560c46787c9d50a3dcf822aebc1ce431a3c5\", \"pdf_unittests\": \"0a7296c9bb8304f85b5313d0162752747a866a70\", \"perfetto_unittests\": \"88330a8bb9b45946edbdd375aba2e1bdc39455c8\", \"ppapi_unittests\": \"1363b6018f79a8617d5776746910d0e5eb5e1c5c\", \"printing_unittests\": \"957278c7ce101f8140213f4d0c7181cca1c4341e\", \"remoting_unittests\": \"b7f0fcf7e564917eb3efd76b07a69b4625b86097\", \"sandbox_linux_unittests\": \"250ea983ede38de2a228e32265b0a670bdec580e\", \"service_manager_unittests\": \"d0602ff7860d1919400d0f11929185b99e3e655d\", \"services_unittests\": \"ffc3a656bef5c8f43bbc4e47ec1c0b59a3819803\", \"shell_dialogs_unittests\": \"1bd9c1ab250820f79a65a4c56f234bef4fe20efa\", \"skia_unittests\": \"83ac9f70de4cae7df82acdfec6499fbde7b1897b\", \"snapshot_unittests\": \"834c4afc7700eeaeb428d625b0eca958953cddd0\", \"sql_unittests\": \"930871529fc73e20925462574ddeac340e84c79b\", \"storage_unittests\": \"6c569c094039022f7d3a4a37f8e6a4b9ec1bb584\", \"sync_integration_tests\": \"0e0a54bc1d82c64c509a189fafd0ad9336bf7a42\", \"traffic_annotation_auditor_unittests\": \"d8863d1bfb716730747cfd0c6b413f1fdfd4104b\", \"ui_base_unittests\": \"f510633f4b3e3bb29a0ffdb3bcee665d30139921\", \"ui_chromeos_unittests\": \"4978ffeabdf2467ae56852fb32f92ac4f581edaa\", \"ui_touch_selection_unittests\": \"e33b6088ae3a574abccb3be542ed075fcf15c04e\", \"unit_tests\": \"29d6d1358713af8a60dc69b8baaa654160d71716\", \"url_unittests\": \"232edca91755f778a7f95e12aa325be45d4cd90e\", \"usage_time_limit_unittests\": \"9cee574458bb39689c7c97b035c4ff587ce131c0\", \"views_unittests\": \"5c2afb059abfa8252215abdd356fa95add0f1cae\", \"viz_unittests\": \"413c4464419436e00c526eb3176af65eab0fefa0\", \"wm_unittests\": \"94189851603767d8960562a607960dab8c60466f\", \"wtf_unittests\": \"875de2dd755ea49602ec270b428178edf01d5f59\"}, \"swarm_hashes_refs/heads/master(at){#645147}_without_patch\": {\"accessibility_unittests\": \"357ce5360b0b456ec4c0eb136781a54d5c0faa6c\", \"angle_unittests\": \"b7e83a0468fee2e71c83bebc5abb036a2c776cde\", \"app_list_unittests\": \"1abdbde82b57fb299ffb40cada56d323233c8a45\", \"app_shell_unittests\": \"9a12230356c3213c1edf7c0b6a6d8d0c612af8d6\", \"ash_unittests\": \"3206ee804c2814aa5d2b147fb2ae6743b323ae29\", \"aura_unittests\": \"197976ca4af9c6d4e99ce82ed3743a5ece0e5258\", \"base_unittests\": \"8cd124dbde82ece516e3dbcf58260e87269b0f6b\", \"blink_common_unittests\": \"c7b333b392120fa60c718134790cbaa0ae2c6b2a\", \"blink_fuzzer_unittests\": \"4f99c11fb90f9c6e370dea7386f22d26366a3662\", \"blink_heap_unittests\": \"480d70b420eb452f86d7ef7a9f4cb0cc79adfcee\", \"blink_platform_unittests\": \"c1f594cc12ac4f7f02830bfea193a4a706e8efc0\", \"blink_unittests\": \"e79f2d811ab568298480941110fe02aad2fcfdc8\", \"boringssl_crypto_tests\": \"114cc5aa8a379d0eef5d13d7e44d4e683de08dc5\", \"boringssl_ssl_tests\": \"294d6f00e233a5248644263a48bf2e729a4fa735\", \"browser_tests\": \"86f3a8fab1dcd78d1216a7e2ff8cc5e06591b8b7\", \"cacheinvalidation_unittests\": \"e9e9d02f07b81f41659fbd04e64e410a9a7a69e7\", \"capture_unittests\": \"ccf58cd0937f5898a0592b0d847250b266b766d8\", \"cast_unittests\": \"e3bfd36b94d9b1f4cef31a9f46c4f89fb8e8a6da\", \"cc_unittests\": \"38b16f145183496bc9829132a92ed829cabbdc23\", \"chrome_app_unittests\": \"1b8648ed05d4ea0581fd7cf2444837d9fb2205b8\", \"chromedriver_unittests\": \"2c8194df711c885078d8b1ff3f0ecc5ea75ad9ff\", \"chromeos_components_unittests\": \"696b453333a87fa932bdfce9a89ed0e903284618\", \"chromeos_unittests\": \"d037f28a7370c1f0078e163505fe4b4ee42e4bcd\", \"components_browsertests\": \"e25d266afb31816ae10e9649a13b61af535ca97d\", \"components_unittests\": \"b09b69893958b9eeb1742d127a08c5bc7e1db9fc\", \"compositor_unittests\": \"2e4cf9a839f7ccacc59366cce8d35a1d4aa507b9\", \"content_browsertests\": \"b8977907c32e2f56728440cbc865ca47bbb53f74\", \"content_unittests\": \"410c659671d9d9105f8a72b41465ee00f0b8702e\", \"crypto_unittests\": \"a37566a163967a0764f271f3e36c84cdb1ca0114\", \"dbus_unittests\": \"56567ce1b8dc1071de6713046cbc56860dfa25c9\", \"device_unittests\": \"c593a214736c12e021ad4277e21c55a6d3d84158\", \"display_unittests\": \"8ce8f1c775aa29cdf18a12588db0fcf1adf75a28\", \"events_unittests\": \"699182ac0862bd212db3360b53a2eab34d9b15a8\", \"exo_unittests\": \"4eb95f4637585860c260baba3e2726ad29a94cb9\", \"extensions_browsertests\": \"43404ff85b68b634f5d41da9840c63cbead1b27c\", \"extensions_unittests\": \"c0bd795403c6660069237ed0a4c40a4e2cc7def4\", \"filesystem_service_unittests\": \"5caf5d15da44e9646a37a63851bd99da6a14487f\", \"gcm_unit_tests\": \"8b63b0f11d38c1ec0987e517d9d223d16c266116\", \"gfx_unittests\": \"f059680206209d3184a74eef75899e281446d6ed\", \"gin_unittests\": \"897e9e7ba50dce6681fb47f474c46418437b3af6\", \"gl_unittests_ozone\": \"e399019f46a93843a2cae558bd1e778f8bce8c81\", \"google_apis_unittests\": \"2a02ec0ed6afb32e2c0f4bb5ec8d9c92b5a0f142\", \"gpu_unittests\": \"e526f8c83da46a780ee49b3b30708d66965bd999\", \"interactive_ui_tests\": \"07d3c2056fbb2be11bbf7f78978f3b3714f00e65\", \"ipc_tests\": \"628e8548b8b171a593463ce2c49a21ed50c05e44\", \"jingle_unittests\": \"4b766b9802a0722e753c8c36f88c80fbca7c25ef\", \"keyboard_unittests\": \"a93b37e58fecd65073204b2e401ee42680ed5996\", \"latency_unittests\": \"cf038ec9f010ff87f1f18781916a2603e9b26916\", \"leveldb_service_unittests\": \"37ed6df2ceb4fd72d12af000f09d7259051f252b\", \"libjingle_xmpp_unittests\": \"29932605e3226fb865102d9c5489546aaaef6d5a\", \"media_blink_unittests\": \"bb55a3039042e782b7f03d4520f14535ec42cfc3\", \"media_service_unittests\": \"993e5d30a579b4619a8459f13a3fef069e527602\", \"media_unittests\": \"53d3c6a8328fccf0428075d8f9f6c4c1eb857837\", \"message_center_unittests\": \"a31647d88c1726edbf35efa1073c0f49c3b3e773\", \"midi_unittests\": \"953de307de9cc72d24a9578cebee469a45ea7021\", \"mojo_core_unittests\": \"db347681f0aaf25ea07dc3979de65af08bae58b1\", \"mojo_unittests\": \"e01ec75d37c1aa601670439550f706b0f343eda2\", \"nacl_helper_nonsfi_unittests\": \"4d0ea0e128624ed500045b530f2711be15548ace\", \"nacl_loader_unittests\": \"c8f5cc43c9068f8ae4b7c8a4632aef629675f496\", \"native_theme_unittests\": \"acb836c6c099a52517d49b76344d8a8b2ecae5ff\", \"net_unittests\": \"d9fb8b313e309e2ab982f02883bc7729b1cebd94\", \"ozone_gl_unittests\": \"4dfe6e1058aab34a397bf4292e0a87ef0576f54f\", \"ozone_unittests\": \"0f11b9567acfba25e32585a0dd80c29c3d85b0fd\", \"ozone_x11_unittests\": \"fd32560c46787c9d50a3dcf822aebc1ce431a3c5\", \"pdf_unittests\": \"0a7296c9bb8304f85b5313d0162752747a866a70\", \"perfetto_unittests\": \"88330a8bb9b45946edbdd375aba2e1bdc39455c8\", \"ppapi_unittests\": \"1363b6018f79a8617d5776746910d0e5eb5e1c5c\", \"printing_unittests\": \"957278c7ce101f8140213f4d0c7181cca1c4341e\", \"remoting_unittests\": \"b7f0fcf7e564917eb3efd76b07a69b4625b86097\", \"sandbox_linux_unittests\": \"250ea983ede38de2a228e32265b0a670bdec580e\", \"service_manager_unittests\": \"d0602ff7860d1919400d0f11929185b99e3e655d\", \"services_unittests\": \"ffc3a656bef5c8f43bbc4e47ec1c0b59a3819803\", \"shell_dialogs_unittests\": \"1bd9c1ab250820f79a65a4c56f234bef4fe20efa\", \"skia_unittests\": \"83ac9f70de4cae7df82acdfec6499fbde7b1897b\", \"snapshot_unittests\": \"834c4afc7700eeaeb428d625b0eca958953cddd0\", \"sql_unittests\": \"930871529fc73e20925462574ddeac340e84c79b\", \"storage_unittests\": \"6c569c094039022f7d3a4a37f8e6a4b9ec1bb584\", \"sync_integration_tests\": \"0e0a54bc1d82c64c509a189fafd0ad9336bf7a42\", \"traffic_annotation_auditor_unittests\": \"d8863d1bfb716730747cfd0c6b413f1fdfd4104b\", \"ui_base_unittests\": \"f510633f4b3e3bb29a0ffdb3bcee665d30139921\", \"ui_chromeos_unittests\": \"4978ffeabdf2467ae56852fb32f92ac4f581edaa\", \"ui_touch_selection_unittests\": \"e33b6088ae3a574abccb3be542ed075fcf15c04e\", \"unit_tests\": \"29d6d1358713af8a60dc69b8baaa654160d71716\", \"url_unittests\": \"232edca91755f778a7f95e12aa325be45d4cd90e\", \"usage_time_limit_unittests\": \"9cee574458bb39689c7c97b035c4ff587ce131c0\", \"views_unittests\": \"5c2afb059abfa8252215abdd356fa95add0f1cae\", \"viz_unittests\": \"413c4464419436e00c526eb3176af65eab0fefa0\", \"wm_unittests\": \"94189851603767d8960562a607960dab8c60466f\", \"wtf_unittests\": \"875de2dd755ea49602ec270b428178edf01d5f59\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4224-5f5030f\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 tests failed: ['non_network_service_browser_tests', 'non_network_service_interactive_ui_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1553739868495004",
"status": "COMPLETED",
"status_changed_ts": "1553739868779763",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11576",
"builder:linux-chromeos-dbg",
"buildset:commit/git/579a7ac901b959771acf2881e2c8643c4c737d24",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/579a7ac901b959771acf2881e2c8643c4c737d24",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083209820270519440",
"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/8917779758315859344/+/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:43dae8f16556f310",
"user_agent:luci-scheduler"
],
"updated_ts": "1553745301374069",
"url": "https://ci.chromium.org/b/8917779758315859344",
"utcnow_ts": "1553745301859355"
}
}
[03:55:01.872] Invocation finished in 1h36m35.786379476s with status FAILED