[11:07:11.012] New invocation is queued and will start shortly
[11:07:12.184] Starting the invocation (attempt 1)
[11:07:12.224] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:07:12.224] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:07:12.224] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021298826242156016",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9021298826242156016",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc",
"gitiles_ref:refs/heads/master"
]
}
[11:07:13.397] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612782432319283",
"id": "8855868764206982272",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612782433129271",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22532",
"builder:linux-chromeos-dbg",
"buildset:commit/git/74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021298826242156016",
"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/8855868764206982272/+/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": "1612782433129497",
"url": "https://ci.chromium.org/b/8855868764206982272",
"utcnow_ts": "1612782433386338"
}
}
[11:07:13.397] Task URL: https://ci.chromium.org/b/8855868764206982272
[11:07:13.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:2:0) after 1m0s
[11:08:13.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:2:0)
[11:08:13.514] Timer tick, asking Buildbucket for the build status
[11:08:13.825] Build 8855868764206982272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:08:13.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:3:0) after 1m0s
[11:09:13.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:3:0)
[11:09:13.867] Timer tick, asking Buildbucket for the build status
[11:09:14.084] Build 8855868764206982272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:09:14.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:4:0) after 1m0s
[11:10:14.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:4:0)
[11:10:14.096] Timer tick, asking Buildbucket for the build status
[11:10:14.246] Build 8855868764206982272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:10:14.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:5:0) after 1m0s
[11:11:14.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:5:0)
[11:11:14.218] Timer tick, asking Buildbucket for the build status
[11:11:14.380] Build 8855868764206982272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:11:14.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:6:0) after 1m0s
[11:12:04.750] Received PubSub notification, asking Buildbucket for the build status
[11:12:04.999] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:14.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:6:0)
[11:12:14.401] Timer tick, asking Buildbucket for the build status
[11:12:14.816] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:14.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:8:0) after 1m0s
[11:13:14.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:8:0)
[11:13:14.833] Timer tick, asking Buildbucket for the build status
[11:13:15.547] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:15.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:9:0) after 1m0s
[11:14:15.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:9:0)
[11:14:15.596] Timer tick, asking Buildbucket for the build status
[11:14:15.662] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:15.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:10:0) after 1m0s
[11:15:15.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:10:0)
[11:15:15.792] Timer tick, asking Buildbucket for the build status
[11:15:15.852] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:15.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:11:0) after 1m0s
[11:16:15.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:11:0)
[11:16:15.869] Timer tick, asking Buildbucket for the build status
[11:16:16.123] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:16.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:12:0) after 1m0s
[11:17:16.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:12:0)
[11:17:16.176] Timer tick, asking Buildbucket for the build status
[11:17:16.518] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:16.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:13:0) after 1m0s
[11:18:16.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:13:0)
[11:18:16.562] Timer tick, asking Buildbucket for the build status
[11:18:16.891] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:16.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:14:0) after 1m0s
[11:19:16.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:14:0)
[11:19:16.902] Timer tick, asking Buildbucket for the build status
[11:19:17.163] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:17.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:15:0) after 1m0s
[11:20:17.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:15:0)
[11:20:17.150] Timer tick, asking Buildbucket for the build status
[11:20:17.236] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:17.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:16:0) after 1m0s
[11:21:17.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:16:0)
[11:21:17.257] Timer tick, asking Buildbucket for the build status
[11:21:17.870] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:17.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:17:0) after 1m0s
[11:22:17.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:17:0)
[11:22:17.970] Timer tick, asking Buildbucket for the build status
[11:22:18.063] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:18.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:18:0) after 1m0s
[11:23:18.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:18:0)
[11:23:18.118] Timer tick, asking Buildbucket for the build status
[11:23:18.706] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:18.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:19:0) after 1m0s
[11:24:18.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:19:0)
[11:24:18.735] Timer tick, asking Buildbucket for the build status
[11:24:18.916] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:18.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:20:0) after 1m0s
[11:25:18.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:20:0)
[11:25:18.916] Timer tick, asking Buildbucket for the build status
[11:25:18.984] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:18.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:21:0) after 1m0s
[11:26:18.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:21:0)
[11:26:18.992] Timer tick, asking Buildbucket for the build status
[11:26:20.019] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:20.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:22:0) after 1m0s
[11:27:20.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:22:0)
[11:27:20.109] Timer tick, asking Buildbucket for the build status
[11:27:20.319] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:20.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:23:0) after 1m0s
[11:28:20.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:23:0)
[11:28:20.344] Timer tick, asking Buildbucket for the build status
[11:28:20.412] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:20.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:24:0) after 1m0s
[11:29:20.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:24:0)
[11:29:20.521] Timer tick, asking Buildbucket for the build status
[11:29:20.630] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:20.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:25:0) after 1m0s
[11:30:20.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:25:0)
[11:30:20.647] Timer tick, asking Buildbucket for the build status
[11:30:21.046] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:21.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:26:0) after 1m0s
[11:31:21.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:26:0)
[11:31:21.045] Timer tick, asking Buildbucket for the build status
[11:31:21.100] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:21.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:27:0) after 1m0s
[11:32:21.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:27:0)
[11:32:21.124] Timer tick, asking Buildbucket for the build status
[11:32:21.240] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:21.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:28:0) after 1m0s
[11:33:21.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:28:0)
[11:33:21.284] Timer tick, asking Buildbucket for the build status
[11:33:21.476] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:21.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:29:0) after 1m0s
[11:34:21.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:29:0)
[11:34:21.514] Timer tick, asking Buildbucket for the build status
[11:34:21.578] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:21.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:30:0) after 1m0s
[11:35:21.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:30:0)
[11:35:21.621] Timer tick, asking Buildbucket for the build status
[11:35:21.696] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:21.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:31:0) after 1m0s
[11:36:21.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:31:0)
[11:36:21.751] Timer tick, asking Buildbucket for the build status
[11:36:21.804] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:21.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:32:0) after 1m0s
[11:37:21.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:32:0)
[11:37:21.834] Timer tick, asking Buildbucket for the build status
[11:37:21.943] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:21.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:33:0) after 1m0s
[11:38:21.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:33:0)
[11:38:21.972] Timer tick, asking Buildbucket for the build status
[11:38:22.035] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:22.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:34:0) after 1m0s
[11:39:22.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:34:0)
[11:39:22.110] Timer tick, asking Buildbucket for the build status
[11:39:22.201] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:22.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:35:0) after 1m0s
[11:40:22.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:35:0)
[11:40:22.362] Timer tick, asking Buildbucket for the build status
[11:40:22.444] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:22.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:36:0) after 1m0s
[11:41:22.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:36:0)
[11:41:22.531] Timer tick, asking Buildbucket for the build status
[11:41:23.053] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:23.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:37:0) after 1m0s
[11:42:23.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:37:0)
[11:42:23.095] Timer tick, asking Buildbucket for the build status
[11:42:23.434] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:23.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:38:0) after 1m0s
[11:43:23.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:38:0)
[11:43:23.477] Timer tick, asking Buildbucket for the build status
[11:43:23.524] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:23.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:39:0) after 1m0s
[11:44:23.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:39:0)
[11:44:23.553] Timer tick, asking Buildbucket for the build status
[11:44:23.628] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:23.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:40:0) after 1m0s
[11:45:23.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:40:0)
[11:45:23.674] Timer tick, asking Buildbucket for the build status
[11:45:24.546] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:24.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:41:0) after 1m0s
[11:46:24.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:41:0)
[11:46:24.554] Timer tick, asking Buildbucket for the build status
[11:46:24.612] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:24.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:42:0) after 1m0s
[11:47:24.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:42:0)
[11:47:24.631] Timer tick, asking Buildbucket for the build status
[11:47:24.754] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:24.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:43:0) after 1m0s
[11:48:24.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:43:0)
[11:48:24.811] Timer tick, asking Buildbucket for the build status
[11:48:24.869] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:24.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:44:0) after 1m0s
[11:49:24.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:44:0)
[11:49:24.902] Timer tick, asking Buildbucket for the build status
[11:49:24.967] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:24.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:45:0) after 1m0s
[11:50:25.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:45:0)
[11:50:25.014] Timer tick, asking Buildbucket for the build status
[11:50:25.086] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:25.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:46:0) after 1m0s
[11:51:25.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:46:0)
[11:51:25.200] Timer tick, asking Buildbucket for the build status
[11:51:25.266] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:25.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:47:0) after 1m0s
[11:52:25.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:47:0)
[11:52:25.402] Timer tick, asking Buildbucket for the build status
[11:52:25.508] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:25.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:48:0) after 1m0s
[11:53:25.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:48:0)
[11:53:25.651] Timer tick, asking Buildbucket for the build status
[11:53:25.759] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:25.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:49:0) after 1m0s
[11:54:25.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:49:0)
[11:54:25.784] Timer tick, asking Buildbucket for the build status
[11:54:25.871] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:25.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:50:0) after 1m0s
[11:55:25.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:50:0)
[11:55:25.962] Timer tick, asking Buildbucket for the build status
[11:55:26.034] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:26.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:51:0) after 1m0s
[11:56:26.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:51:0)
[11:56:26.213] Timer tick, asking Buildbucket for the build status
[11:56:26.282] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:26.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:52:0) after 1m0s
[11:57:26.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:52:0)
[11:57:26.515] Timer tick, asking Buildbucket for the build status
[11:57:27.244] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:27.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:53:0) after 1m0s
[11:58:27.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:53:0)
[11:58:27.310] Timer tick, asking Buildbucket for the build status
[11:58:27.817] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:27.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:54:0) after 1m0s
[11:59:27.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:54:0)
[11:59:27.888] Timer tick, asking Buildbucket for the build status
[11:59:28.043] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:28.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:55:0) after 1m0s
[12:00:28.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:55:0)
[12:00:28.051] Timer tick, asking Buildbucket for the build status
[12:00:28.588] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:28.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:56:0) after 1m0s
[12:01:28.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:56:0)
[12:01:28.691] Timer tick, asking Buildbucket for the build status
[12:01:28.883] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:28.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:57:0) after 1m0s
[12:02:30.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:57:0)
[12:02:30.410] Timer tick, asking Buildbucket for the build status
[12:02:30.559] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:30.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:58:0) after 1m0s
[12:03:30.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:58:0)
[12:03:30.639] Timer tick, asking Buildbucket for the build status
[12:03:31.033] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:31.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:59:0) after 1m0s
[12:04:31.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:59:0)
[12:04:31.077] Timer tick, asking Buildbucket for the build status
[12:04:31.215] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:31.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:60:0) after 1m0s
[12:05:31.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:60:0)
[12:05:31.219] Timer tick, asking Buildbucket for the build status
[12:05:31.341] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:31.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:61:0) after 1m0s
[12:06:31.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:61:0)
[12:06:31.363] Timer tick, asking Buildbucket for the build status
[12:06:31.458] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:31.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:62:0) after 1m0s
[12:07:31.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:62:0)
[12:07:31.453] Timer tick, asking Buildbucket for the build status
[12:07:31.560] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:31.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:63:0) after 1m0s
[12:08:31.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:63:0)
[12:08:31.684] Timer tick, asking Buildbucket for the build status
[12:08:31.768] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:31.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:64:0) after 1m0s
[12:09:31.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:64:0)
[12:09:31.857] Timer tick, asking Buildbucket for the build status
[12:09:32.035] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:32.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:65:0) after 1m0s
[12:10:32.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:65:0)
[12:10:32.135] Timer tick, asking Buildbucket for the build status
[12:10:34.822] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:34.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:66:0) after 1m0s
[12:11:34.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:66:0)
[12:11:34.882] Timer tick, asking Buildbucket for the build status
[12:11:34.944] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:34.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:67:0) after 1m0s
[12:12:34.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:67:0)
[12:12:34.990] Timer tick, asking Buildbucket for the build status
[12:12:35.313] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:35.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:68:0) after 1m0s
[12:13:35.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:68:0)
[12:13:35.307] Timer tick, asking Buildbucket for the build status
[12:13:35.378] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:35.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:69:0) after 1m0s
[12:14:35.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:69:0)
[12:14:35.508] Timer tick, asking Buildbucket for the build status
[12:14:35.728] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:35.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:70:0) after 1m0s
[12:15:35.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:70:0)
[12:15:35.721] Timer tick, asking Buildbucket for the build status
[12:15:36.459] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:36.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:71:0) after 1m0s
[12:16:36.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:71:0)
[12:16:36.485] Timer tick, asking Buildbucket for the build status
[12:16:36.598] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:36.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:72:0) after 1m0s
[12:17:36.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:72:0)
[12:17:36.652] Timer tick, asking Buildbucket for the build status
[12:17:36.784] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:36.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:73:0) after 1m0s
[12:18:36.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:73:0)
[12:18:36.818] Timer tick, asking Buildbucket for the build status
[12:18:38.096] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:38.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:74:0) after 1m0s
[12:19:38.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:74:0)
[12:19:38.150] Timer tick, asking Buildbucket for the build status
[12:19:38.260] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:38.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:75:0) after 1m0s
[12:20:38.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:75:0)
[12:20:38.347] Timer tick, asking Buildbucket for the build status
[12:20:38.507] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:38.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:76:0) after 1m0s
[12:21:38.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:76:0)
[12:21:38.581] Timer tick, asking Buildbucket for the build status
[12:21:38.713] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:38.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:77:0) after 1m0s
[12:22:38.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:77:0)
[12:22:38.719] Timer tick, asking Buildbucket for the build status
[12:22:38.842] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:38.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:78:0) after 1m0s
[12:23:38.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:78:0)
[12:23:38.883] Timer tick, asking Buildbucket for the build status
[12:23:38.953] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:38.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:79:0) after 1m0s
[12:24:38.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:79:0)
[12:24:38.950] Timer tick, asking Buildbucket for the build status
[12:24:40.262] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:40.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:80:0) after 1m0s
[12:25:40.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:80:0)
[12:25:40.312] Timer tick, asking Buildbucket for the build status
[12:25:40.672] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:40.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:81:0) after 1m0s
[12:26:40.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:81:0)
[12:26:40.668] Timer tick, asking Buildbucket for the build status
[12:26:41.853] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:41.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:82:0) after 1m0s
[12:27:41.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:82:0)
[12:27:41.925] Timer tick, asking Buildbucket for the build status
[12:27:42.089] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:42.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:83:0) after 1m0s
[12:28:42.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:83:0)
[12:28:42.115] Timer tick, asking Buildbucket for the build status
[12:28:42.222] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:42.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:84:0) after 1m0s
[12:29:42.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:84:0)
[12:29:42.247] Timer tick, asking Buildbucket for the build status
[12:29:42.321] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:42.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:85:0) after 1m0s
[12:30:42.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:85:0)
[12:30:42.396] Timer tick, asking Buildbucket for the build status
[12:30:42.532] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:42.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:86:0) after 1m0s
[12:31:42.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:86:0)
[12:31:42.584] Timer tick, asking Buildbucket for the build status
[12:31:42.852] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:42.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:87:0) after 1m0s
[12:32:42.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:87:0)
[12:32:42.848] Timer tick, asking Buildbucket for the build status
[12:32:43.421] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:43.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:88:0) after 1m0s
[12:33:43.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:88:0)
[12:33:43.442] Timer tick, asking Buildbucket for the build status
[12:33:43.514] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:43.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:89:0) after 1m0s
[12:34:43.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:89:0)
[12:34:43.521] Timer tick, asking Buildbucket for the build status
[12:34:43.711] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:43.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:90:0) after 1m0s
[12:35:43.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:90:0)
[12:35:43.744] Timer tick, asking Buildbucket for the build status
[12:35:43.816] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:43.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:91:0) after 1m0s
[12:36:43.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:91:0)
[12:36:43.893] Timer tick, asking Buildbucket for the build status
[12:36:44.243] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:44.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:92:0) after 1m0s
[12:37:44.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:92:0)
[12:37:44.298] Timer tick, asking Buildbucket for the build status
[12:37:44.431] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:44.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:93:0) after 1m0s
[12:38:44.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:93:0)
[12:38:44.619] Timer tick, asking Buildbucket for the build status
[12:38:44.729] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:44.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:94:0) after 1m0s
[12:39:44.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:94:0)
[12:39:44.826] Timer tick, asking Buildbucket for the build status
[12:39:44.888] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:44.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:95:0) after 1m0s
[12:40:44.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:95:0)
[12:40:44.931] Timer tick, asking Buildbucket for the build status
[12:40:44.999] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:44.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:96:0) after 1m0s
[12:41:45.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:96:0)
[12:41:45.024] Timer tick, asking Buildbucket for the build status
[12:41:45.108] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:45.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:97:0) after 1m0s
[12:42:45.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:97:0)
[12:42:45.173] Timer tick, asking Buildbucket for the build status
[12:42:45.340] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:45.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:98:0) after 1m0s
[12:43:45.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:98:0)
[12:43:45.361] Timer tick, asking Buildbucket for the build status
[12:43:45.617] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:45.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:99:0) after 1m0s
[12:44:45.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:99:0)
[12:44:45.786] Timer tick, asking Buildbucket for the build status
[12:44:46.944] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:46.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:100:0) after 1m0s
[12:45:46.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:100:0)
[12:45:46.984] Timer tick, asking Buildbucket for the build status
[12:45:47.171] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:47.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:101:0) after 1m0s
[12:46:47.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:101:0)
[12:46:47.195] Timer tick, asking Buildbucket for the build status
[12:46:47.261] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:47.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:102:0) after 1m0s
[12:47:47.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:102:0)
[12:47:47.360] Timer tick, asking Buildbucket for the build status
[12:47:47.623] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:47.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:103:0) after 1m0s
[12:48:47.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:103:0)
[12:48:47.644] Timer tick, asking Buildbucket for the build status
[12:48:48.056] Build 8855868764206982272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:48.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021298826242156016:104:0) after 1m0s
[12:49:42.502] Received PubSub notification, asking Buildbucket for the build status
[12:49:42.633] Build 8855868764206982272: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:49:42.633] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612788581841073",
"created_by": "project:chromium",
"created_ts": "1612782432319283",
"failure_reason": "BUILD_FAILURE",
"id": "8855868764206982272",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- ManifestBrowserTest.CorsManifest\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-77-cvdy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22532, \"got_angle_revision\": \"5712107a35b053c2e4ffb3a5690e6e482a0c84f5\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc\", \"got_revision_cp\": \"refs/heads/master@{#851655}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"462378addab907ab7452d38baccb27fe2ef7289a\", \"got_v8_revision_cp\": \"refs/heads/9.0.138@{#1}\", \"got_webrtc_revision\": \"69c0118c5139a1a6b431d2f3f812dc9ed6af6b74\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33186}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc\", \"swarm_hashes_refs/heads/master(at){#851655}_without_patch\": {\"absl_hardening_tests\": \"ccfcd32010fee0464b3d80e72d9585b31c68d1a4\", \"accessibility_unittests\": \"1cb2e275fbfa8fddda0f73d4df14a6d8e3f59dbd\", \"angle_unittests\": \"1bf23a0289f510bf93d6f466def13d874334a62e\", \"app_list_unittests\": \"f6b4962bd30b24ade6f6958b48d2543f22fd74f6\", \"app_shell_unittests\": \"0581295d804baca860784691239266a2abd165ca\", \"ash_unittests\": \"6f5e002a7cc616613417e06f84e734435e33e2ac\", \"aura_unittests\": \"b4d75f2454da4e6496979380bea7670bfcdb3dbe\", \"base_unittests\": \"7911c1e6708016433fceee05af2cf1554e5cbc4a\", \"base_util_unittests\": \"28d5f7b32d07d429a1ab8d1c81104f47aa6f0c8d\", \"blink_common_unittests\": \"f893d40911f2bd6ca5a9a15732facb4ef7cdea48\", \"blink_fuzzer_unittests\": \"a3a6e7ab7d40718a878bfc4d496d64bdc5342b66\", \"blink_heap_unittests\": \"68be6953ec4774c356b195b8bd41c68e35e58e15\", \"blink_platform_unittests\": \"ee36904131c2397097ab8e9d83f27065c6430ee7\", \"blink_unittests\": \"ab51f181ba055a7626c8916e229b3d34a542b8bc\", \"boringssl_crypto_tests\": \"de1ec3e779e5e8a915663311e6bdb2d993dd83c1\", \"boringssl_ssl_tests\": \"6435d8f35a1b99db027424792c85a30888c4b3df\", \"browser_tests\": \"ba42697935419386714eff2b81ce4b231e72a0e9\", \"capture_unittests\": \"fc0b7030890dc9c9deac0e0baab49f47df04ab23\", \"cast_unittests\": \"bbf0d5203093d039ca50bb1fb4fb1d584d9fefee\", \"cc_unittests\": \"de839360d0b8997ed427c5893a85a6500467fc68\", \"chrome_app_unittests\": \"afd0d6e6d9ca727eb8c8d75bbaff5ee7f5e4a169\", \"chromedriver_unittests\": \"6b08722f986c7a8ec851a32cf86fc4b655f618c7\", \"chromeos_components_unittests\": \"ce745c113bbb2508d86a3bddceab1debb75ccfae\", \"chromeos_unittests\": \"b61b540d99f1f2315108b24f2a72e6f4840d4b04\", \"components_browsertests\": \"cf438823dd89ccf8dce90ec420024abad021b630\", \"components_unittests\": \"95905d4ad970bd1a33284d450a439678cf6f1881\", \"compositor_unittests\": \"67ad5dc0eec4b1068d625c0bc7c885fce2112291\", \"content_browsertests\": \"d2727f1cce4f9e457a9943fb309e74a922cd465b\", \"content_unittests\": \"d62fcdc530dbe1a16beb2d5e60f1d62ef3e9e72e\", \"crashpad_tests\": \"08e0a172debfc2dea101fe6ebcc379cc2eeaf8f0\", \"crypto_unittests\": \"9501ced4d5760a4cec709338e13edb72d2bd366b\", \"dbus_unittests\": \"e0fd20b9079452c5c4a7e32c8e7cbb3ec04d4bb5\", \"device_unittests\": \"1b0cde9cd50056dcb7ac22039ec580626e247b19\", \"display_unittests\": \"3b9abe2fca8755193befce59a49cfe672eea93d6\", \"events_unittests\": \"fa6056c6e6e74c2627edf290615fba102811aca5\", \"exo_unittests\": \"186bdd7c8ff8c7ac9d58335d3ec931777837d5d8\", \"extensions_browsertests\": \"19aa530e39ff06ab50130d7af31c6bfb295d54ef\", \"extensions_unittests\": \"c88d20b7511b166ccea3117a0932154c74fdab94\", \"filesystem_service_unittests\": \"ccffd678c692ff8049903a7dc1030d79b17e3921\", \"gcm_unit_tests\": \"b37e578479e17cbe952122f924f8b4ead86315dd\", \"gfx_unittests\": \"1d89d369df6f982db6453009ed8166432b25fad5\", \"gin_unittests\": \"31ad7988341a95bf0db3f1f1ea9a67b06fa1d869\", \"gl_unittests_ozone\": \"73e496a71e48e675075c7300d9801ec7743cc620\", \"google_apis_unittests\": \"7049c7253c7012aa7f31edfefb2c010a41b3a479\", \"gpu_unittests\": \"452b71771bfb0a49f2576de0c99392dcee391547\", \"gwp_asan_unittests\": \"9b7252004a82566a16d8f4786a926ff534263e5a\", \"interactive_ui_tests\": \"3f2ade2097d90396582f238241cc0c8869ba969d\", \"ipc_tests\": \"c76e50f9c2a43d71cb2f82e8c6b881de1856fad9\", \"jingle_unittests\": \"9e6d7e437bad26fdc9c95c611a58da0ad6c41dc1\", \"keyboard_unittests\": \"f5a3dfe2775c1918d0daf2a3a4775fc35952aef7\", \"latency_unittests\": \"45d1044f18816c6e1d973e0eadbb05abdd7a3d97\", \"libjingle_xmpp_unittests\": \"6a56a1e6b176936e713a2aeadeee2ad31d3e69f9\", \"liburlpattern_unittests\": \"ffd52454377393000c95b62bda63ad6d4b087645\", \"media_blink_unittests\": \"fe608acb94d14b512bfe3f8f9f701b4555d1f4b4\", \"media_unittests\": \"5305e8929eea784810d7f35c605cdd6739d1a855\", \"message_center_unittests\": \"4b673540fb7c0becbc04f09481be24c25f78005c\", \"midi_unittests\": \"00a2a6030019a7ca7f83935ad43547a10cb693d1\", \"mojo_core_unittests\": \"5a241153f79709fd8c8cdfc183b34b79c52c1560\", \"mojo_unittests\": \"56a6ca36d1d2bbdc6cd080b7b8c1a9b3efc2aa6f\", \"nacl_helper_nonsfi_unittests\": \"f5ef8ae4ff75abcb03540bf06df2baab6783c98d\", \"nacl_loader_unittests\": \"23aa25c2bd96f28244e8939b4cdbed34fd715a99\", \"native_theme_unittests\": \"eeca9232cf4fb4e57af90934067691d9360f8b53\", \"net_unittests\": \"18098ab064e56b45c60f889492b00b751db9d71c\", \"ozone_gl_unittests\": \"32e88de141f7fae3050d43078ad44a12f1f64bfb\", \"ozone_unittests\": \"3162b7bde773fdc5fa99dd4d3eb21bb32757ea96\", \"ozone_x11_unittests\": \"ebf687783305138043fbc5c5374276772b357d44\", \"pdf_unittests\": \"e85583a50e29f7ba093f8584a324b852c806254c\", \"perfetto_unittests\": \"760a28e4bcffac782aa339a8f1052805c43d5b4f\", \"ppapi_unittests\": \"417c6a1cac885741839c1bdad0c824e4d5f14d3f\", \"printing_unittests\": \"b44c8c28045ab6ad6c18f55727d90eec517aacbd\", \"remoting_unittests\": \"e162c475d3373c80d22e7311bbcb776ec90800e6\", \"sandbox_linux_unittests\": \"0756ec5d242b53e752dabb6e3a968f1f02df5902\", \"service_manager_unittests\": \"d3dbd35f58dc4e054af711f48161e3ab547f61cc\", \"services_unittests\": \"7c43459e3fef3c31e1d6f111dd525ab67650031e\", \"shell_dialogs_unittests\": \"15c0545e66f9e2e81b64555cb6ca004d0ef36e56\", \"shell_encryption_unittests\": \"5c7e3ebdff166c1cbb3a8de52443ae23d271a239\", \"skia_unittests\": \"5fe93995c9ce57da62315458dc68f14f4dd9d0a9\", \"snapshot_unittests\": \"880fa86e7207ee2906953f57021b7a1435fcffa3\", \"sql_unittests\": \"2af2a69819c7b9cb09f8558540f971f53326fec4\", \"storage_unittests\": \"80d7849068a202cc1dc2cbe07806b0ef0084f51d\", \"sync_integration_tests\": \"a3428b7c1b0e59999561ef2dde115183442e3902\", \"traffic_annotation_auditor_unittests\": \"d23a8cbb4b0a70155bedac91fc64c070719e88be\", \"ui_base_unittests\": \"309f738a3e6f211ae9c33d25bab6696f98e1fb2d\", \"ui_chromeos_unittests\": \"3588250506314c5a4e321d169509f45b1b832967\", \"ui_touch_selection_unittests\": \"359b2b3cd49d8215a58dc17ec59c2af8b592bd68\", \"unit_tests\": \"b7f6532644075debd7d519998fa91393529a9b4b\", \"url_unittests\": \"9ede895b1c5b03be789642599b8bdb3db9f19825\", \"usage_time_limit_unittests\": \"1b2c18324c292692344a7c51a4f851e8adf590ba\", \"views_unittests\": \"af96f5aedbff475acc7201c33091e4afec1e28e6\", \"viz_unittests\": \"41625841fb67744fcd937575271d6f971759a7ff\", \"wm_unittests\": \"a01196cf486b1aecfa173e9f790675f543079799\", \"wtf_unittests\": \"c5ce44106a50b063ea32e1d1514166d2d594d60d\", \"zlib_unittests\": \"4b13ee21c4f9f7f2f8f03a400dfc588ee6767934\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-77-cvdy\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5681-01e7fd1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- ManifestBrowserTest.CorsManifest\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612782723725856",
"status": "COMPLETED",
"status_changed_ts": "1612782724293244",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22532",
"builder:linux-chromeos-dbg",
"buildset:commit/git/74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74bc846b78ffad0ffd2e2b20cf5c55cef3544bfc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021298826242156016",
"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/8855868764206982272/+/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:519a247cd0792f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612788582079340",
"url": "https://ci.chromium.org/b/8855868764206982272",
"utcnow_ts": "1612788582624943"
}
}
[12:49:42.633] Invocation finished in 1h42m31.638622054s with status FAILED