[02:57:48.637] New invocation is queued and will start shortly
[02:57:49.992] Starting the invocation (attempt 1)
[02:57:50.092] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:57:50.092] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:57:50.092] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031204684261518416",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d5f1b896c259c0a2bf9768098be9de544f182bd7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031204684261518416",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d5f1b896c259c0a2bf9768098be9de544f182bd7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d5f1b896c259c0a2bf9768098be9de544f182bd7",
"gitiles_ref:refs/heads/master"
]
}
[02:57:50.813] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603335470174386",
"id": "8865774621984886496",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d5f1b896c259c0a2bf9768098be9de544f182bd7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603335470607889",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20957",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d5f1b896c259c0a2bf9768098be9de544f182bd7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d5f1b896c259c0a2bf9768098be9de544f182bd7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031204684261518416",
"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/8865774621984886496/+/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": "1603335470608041",
"url": "https://ci.chromium.org/b/8865774621984886496",
"utcnow_ts": "1603335470802684"
}
}
[02:57:50.813] Task URL: https://ci.chromium.org/b/8865774621984886496
[02:57:50.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:2:0) after 1m0s
[02:58:50.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:2:0)
[02:58:50.831] Timer tick, asking Buildbucket for the build status
[02:58:50.930] Build 8865774621984886496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:50.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:3:0) after 1m0s
[02:59:50.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:3:0)
[02:59:50.948] Timer tick, asking Buildbucket for the build status
[02:59:51.288] Build 8865774621984886496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:51.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:4:0) after 1m0s
[03:00:51.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:4:0)
[03:00:51.319] Timer tick, asking Buildbucket for the build status
[03:00:51.437] Build 8865774621984886496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:51.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:5:0) after 1m0s
[03:01:51.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:5:0)
[03:01:51.495] Timer tick, asking Buildbucket for the build status
[03:01:51.570] Build 8865774621984886496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:51.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:6:0) after 1m0s
[03:02:05.570] Received PubSub notification, asking Buildbucket for the build status
[03:02:05.640] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:51.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:6:0)
[03:02:51.589] Timer tick, asking Buildbucket for the build status
[03:02:51.713] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:51.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:8:0) after 1m0s
[03:03:51.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:8:0)
[03:03:51.748] Timer tick, asking Buildbucket for the build status
[03:03:51.868] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:51.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:9:0) after 1m0s
[03:04:51.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:9:0)
[03:04:51.975] Timer tick, asking Buildbucket for the build status
[03:04:52.040] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:52.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:10:0) after 1m0s
[03:05:52.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:10:0)
[03:05:52.103] Timer tick, asking Buildbucket for the build status
[03:05:52.394] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:52.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:11:0) after 1m0s
[03:06:52.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:11:0)
[03:06:52.452] Timer tick, asking Buildbucket for the build status
[03:06:52.544] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:52.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:12:0) after 1m0s
[03:07:52.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:12:0)
[03:07:52.668] Timer tick, asking Buildbucket for the build status
[03:07:52.778] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:52.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:13:0) after 1m0s
[03:08:52.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:13:0)
[03:08:52.868] Timer tick, asking Buildbucket for the build status
[03:08:52.958] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:52.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:14:0) after 1m0s
[03:09:52.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:14:0)
[03:09:52.983] Timer tick, asking Buildbucket for the build status
[03:09:53.116] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:53.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:15:0) after 1m0s
[03:10:53.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:15:0)
[03:10:53.178] Timer tick, asking Buildbucket for the build status
[03:10:53.310] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:53.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:16:0) after 1m0s
[03:11:53.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:16:0)
[03:11:53.429] Timer tick, asking Buildbucket for the build status
[03:11:53.489] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:53.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:17:0) after 1m0s
[03:12:53.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:17:0)
[03:12:53.597] Timer tick, asking Buildbucket for the build status
[03:12:53.725] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:53.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:18:0) after 1m0s
[03:13:53.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:18:0)
[03:13:53.868] Timer tick, asking Buildbucket for the build status
[03:13:53.931] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:53.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:19:0) after 1m0s
[03:14:53.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:19:0)
[03:14:53.955] Timer tick, asking Buildbucket for the build status
[03:14:54.024] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:54.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:20:0) after 1m0s
[03:15:54.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:20:0)
[03:15:54.006] Timer tick, asking Buildbucket for the build status
[03:15:54.113] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:54.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:21:0) after 1m0s
[03:16:54.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:21:0)
[03:16:54.166] Timer tick, asking Buildbucket for the build status
[03:16:54.265] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:54.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:22:0) after 1m0s
[03:17:54.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:22:0)
[03:17:54.310] Timer tick, asking Buildbucket for the build status
[03:17:54.439] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:54.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:23:0) after 1m0s
[03:18:54.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:23:0)
[03:18:54.597] Timer tick, asking Buildbucket for the build status
[03:18:54.665] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:54.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:24:0) after 1m0s
[03:19:54.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:24:0)
[03:19:54.818] Timer tick, asking Buildbucket for the build status
[03:19:54.879] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:54.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:25:0) after 1m0s
[03:20:54.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:25:0)
[03:20:54.876] Timer tick, asking Buildbucket for the build status
[03:20:55.076] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:55.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:26:0) after 1m0s
[03:21:55.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:26:0)
[03:21:55.117] Timer tick, asking Buildbucket for the build status
[03:21:55.200] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:55.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:27:0) after 1m0s
[03:22:55.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:27:0)
[03:22:55.229] Timer tick, asking Buildbucket for the build status
[03:22:55.327] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:55.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:28:0) after 1m0s
[03:23:55.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:28:0)
[03:23:55.352] Timer tick, asking Buildbucket for the build status
[03:23:55.419] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:55.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:29:0) after 1m0s
[03:24:55.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:29:0)
[03:24:55.436] Timer tick, asking Buildbucket for the build status
[03:24:55.527] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:55.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:30:0) after 1m0s
[03:25:55.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:30:0)
[03:25:55.586] Timer tick, asking Buildbucket for the build status
[03:25:55.644] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:55.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:31:0) after 1m0s
[03:26:55.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:31:0)
[03:26:55.767] Timer tick, asking Buildbucket for the build status
[03:26:55.861] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:55.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:32:0) after 1m0s
[03:27:56.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:32:0)
[03:27:56.042] Timer tick, asking Buildbucket for the build status
[03:27:56.163] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:56.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:33:0) after 1m0s
[03:28:56.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:33:0)
[03:28:56.205] Timer tick, asking Buildbucket for the build status
[03:28:56.265] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:56.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:34:0) after 1m0s
[03:29:56.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:34:0)
[03:29:56.365] Timer tick, asking Buildbucket for the build status
[03:29:56.435] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:56.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:35:0) after 1m0s
[03:30:56.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:35:0)
[03:30:56.525] Timer tick, asking Buildbucket for the build status
[03:30:56.591] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:56.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:36:0) after 1m0s
[03:31:56.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:36:0)
[03:31:56.821] Timer tick, asking Buildbucket for the build status
[03:31:56.878] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:56.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:37:0) after 1m0s
[03:32:56.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:37:0)
[03:32:56.936] Timer tick, asking Buildbucket for the build status
[03:32:57.067] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:57.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:38:0) after 1m0s
[03:33:57.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:38:0)
[03:33:57.101] Timer tick, asking Buildbucket for the build status
[03:33:57.187] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:57.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:39:0) after 1m0s
[03:34:57.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:39:0)
[03:34:57.233] Timer tick, asking Buildbucket for the build status
[03:34:57.293] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:57.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:40:0) after 1m0s
[03:35:57.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:40:0)
[03:35:57.354] Timer tick, asking Buildbucket for the build status
[03:35:57.518] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:57.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:41:0) after 1m0s
[03:36:57.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:41:0)
[03:36:57.554] Timer tick, asking Buildbucket for the build status
[03:36:57.708] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:57.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:42:0) after 1m0s
[03:37:57.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:42:0)
[03:37:57.783] Timer tick, asking Buildbucket for the build status
[03:37:57.887] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:57.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:43:0) after 1m0s
[03:38:57.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:43:0)
[03:38:57.985] Timer tick, asking Buildbucket for the build status
[03:38:58.048] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:58.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:44:0) after 1m0s
[03:39:58.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:44:0)
[03:39:58.083] Timer tick, asking Buildbucket for the build status
[03:39:58.193] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:58.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:45:0) after 1m0s
[03:40:58.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:45:0)
[03:40:58.246] Timer tick, asking Buildbucket for the build status
[03:40:58.364] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:58.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:46:0) after 1m0s
[03:41:58.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:46:0)
[03:41:58.455] Timer tick, asking Buildbucket for the build status
[03:41:58.595] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:58.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:47:0) after 1m0s
[03:42:58.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:47:0)
[03:42:58.674] Timer tick, asking Buildbucket for the build status
[03:42:58.778] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:58.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:48:0) after 1m0s
[03:43:58.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:48:0)
[03:43:58.838] Timer tick, asking Buildbucket for the build status
[03:43:58.914] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:58.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:49:0) after 1m0s
[03:44:58.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:49:0)
[03:44:58.941] Timer tick, asking Buildbucket for the build status
[03:44:59.015] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:59.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:50:0) after 1m0s
[03:45:59.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:50:0)
[03:45:59.056] Timer tick, asking Buildbucket for the build status
[03:45:59.120] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:59.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:51:0) after 1m0s
[03:46:59.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:51:0)
[03:46:59.152] Timer tick, asking Buildbucket for the build status
[03:46:59.230] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:59.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:52:0) after 1m0s
[03:47:59.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:52:0)
[03:47:59.269] Timer tick, asking Buildbucket for the build status
[03:47:59.379] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:59.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:53:0) after 1m0s
[03:48:59.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:53:0)
[03:48:59.485] Timer tick, asking Buildbucket for the build status
[03:48:59.593] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:59.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:54:0) after 1m0s
[03:49:59.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:54:0)
[03:49:59.619] Timer tick, asking Buildbucket for the build status
[03:50:00.196] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:00.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:55:0) after 1m0s
[03:51:00.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:55:0)
[03:51:00.181] Timer tick, asking Buildbucket for the build status
[03:51:00.274] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:00.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:56:0) after 1m0s
[03:52:00.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:56:0)
[03:52:00.323] Timer tick, asking Buildbucket for the build status
[03:52:00.582] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:00.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:57:0) after 1m0s
[03:53:00.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:57:0)
[03:53:00.613] Timer tick, asking Buildbucket for the build status
[03:53:01.807] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:01.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:58:0) after 1m0s
[03:54:01.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:58:0)
[03:54:01.835] Timer tick, asking Buildbucket for the build status
[03:54:02.102] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:02.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:59:0) after 1m0s
[03:55:02.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:59:0)
[03:55:02.222] Timer tick, asking Buildbucket for the build status
[03:55:02.359] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:02.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:60:0) after 1m0s
[03:56:02.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:60:0)
[03:56:02.448] Timer tick, asking Buildbucket for the build status
[03:56:03.087] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:03.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:61:0) after 1m0s
[03:57:03.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:61:0)
[03:57:03.107] Timer tick, asking Buildbucket for the build status
[03:57:03.408] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:03.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:62:0) after 1m0s
[03:58:03.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:62:0)
[03:58:03.439] Timer tick, asking Buildbucket for the build status
[03:58:03.547] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:03.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:63:0) after 1m0s
[03:59:03.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:63:0)
[03:59:03.573] Timer tick, asking Buildbucket for the build status
[03:59:03.767] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:03.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:64:0) after 1m0s
[04:00:03.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:64:0)
[04:00:03.829] Timer tick, asking Buildbucket for the build status
[04:00:04.039] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:04.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:65:0) after 1m0s
[04:01:04.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:65:0)
[04:01:04.043] Timer tick, asking Buildbucket for the build status
[04:01:04.634] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:04.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:66:0) after 1m0s
[04:02:04.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:66:0)
[04:02:04.650] Timer tick, asking Buildbucket for the build status
[04:02:04.835] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:04.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:67:0) after 1m0s
[04:03:04.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:67:0)
[04:03:04.908] Timer tick, asking Buildbucket for the build status
[04:03:05.053] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:05.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:68:0) after 1m0s
[04:04:05.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:68:0)
[04:04:05.194] Timer tick, asking Buildbucket for the build status
[04:04:05.312] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:05.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:69:0) after 1m0s
[04:05:05.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:69:0)
[04:05:05.387] Timer tick, asking Buildbucket for the build status
[04:05:05.519] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:05.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:70:0) after 1m0s
[04:06:05.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:70:0)
[04:06:05.680] Timer tick, asking Buildbucket for the build status
[04:06:05.785] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:05.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:71:0) after 1m0s
[04:07:06.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:71:0)
[04:07:06.034] Timer tick, asking Buildbucket for the build status
[04:07:06.196] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:06.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:72:0) after 1m0s
[04:08:06.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:72:0)
[04:08:06.518] Timer tick, asking Buildbucket for the build status
[04:08:06.631] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:06.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:73:0) after 1m0s
[04:09:06.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:73:0)
[04:09:06.744] Timer tick, asking Buildbucket for the build status
[04:09:06.812] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:06.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:74:0) after 1m0s
[04:10:07.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:74:0)
[04:10:07.121] Timer tick, asking Buildbucket for the build status
[04:10:07.364] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:07.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:75:0) after 1m0s
[04:11:07.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:75:0)
[04:11:07.472] Timer tick, asking Buildbucket for the build status
[04:11:07.544] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:07.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:76:0) after 1m0s
[04:12:07.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:76:0)
[04:12:07.730] Timer tick, asking Buildbucket for the build status
[04:12:08.284] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:08.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:77:0) after 1m0s
[04:13:08.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:77:0)
[04:13:08.328] Timer tick, asking Buildbucket for the build status
[04:13:08.426] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:08.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:78:0) after 1m0s
[04:14:08.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:78:0)
[04:14:08.514] Timer tick, asking Buildbucket for the build status
[04:14:08.690] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:08.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:79:0) after 1m0s
[04:15:08.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:79:0)
[04:15:08.732] Timer tick, asking Buildbucket for the build status
[04:15:08.901] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:08.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:80:0) after 1m0s
[04:16:08.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:80:0)
[04:16:08.981] Timer tick, asking Buildbucket for the build status
[04:16:09.056] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:09.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:81:0) after 1m0s
[04:17:09.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:81:0)
[04:17:09.185] Timer tick, asking Buildbucket for the build status
[04:17:09.266] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:09.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:82:0) after 1m0s
[04:18:09.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:82:0)
[04:18:09.375] Timer tick, asking Buildbucket for the build status
[04:18:09.822] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:09.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:83:0) after 1m0s
[04:19:10.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:83:0)
[04:19:10.494] Timer tick, asking Buildbucket for the build status
[04:19:10.802] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:10.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:84:0) after 1m0s
[04:20:10.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:84:0)
[04:20:10.947] Timer tick, asking Buildbucket for the build status
[04:20:11.476] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:11.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:85:0) after 1m0s
[04:21:11.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:85:0)
[04:21:11.632] Timer tick, asking Buildbucket for the build status
[04:21:12.124] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:12.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:86:0) after 1m0s
[04:22:12.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:86:0)
[04:22:12.266] Timer tick, asking Buildbucket for the build status
[04:22:12.336] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:12.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:87:0) after 1m0s
[04:23:12.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:87:0)
[04:23:12.411] Timer tick, asking Buildbucket for the build status
[04:23:12.522] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:12.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:88:0) after 1m0s
[04:24:12.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:88:0)
[04:24:12.733] Timer tick, asking Buildbucket for the build status
[04:24:12.813] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:12.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:89:0) after 1m0s
[04:25:12.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:89:0)
[04:25:12.993] Timer tick, asking Buildbucket for the build status
[04:25:13.131] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:13.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:90:0) after 1m0s
[04:26:13.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:90:0)
[04:26:13.268] Timer tick, asking Buildbucket for the build status
[04:26:13.353] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:13.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:91:0) after 1m0s
[04:27:13.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:91:0)
[04:27:13.485] Timer tick, asking Buildbucket for the build status
[04:27:13.616] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:13.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:92:0) after 1m0s
[04:28:13.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:92:0)
[04:28:13.821] Timer tick, asking Buildbucket for the build status
[04:28:14.581] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:14.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:93:0) after 1m0s
[04:29:14.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:93:0)
[04:29:14.788] Timer tick, asking Buildbucket for the build status
[04:29:15.045] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:15.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:94:0) after 1m0s
[04:30:15.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:94:0)
[04:30:15.162] Timer tick, asking Buildbucket for the build status
[04:30:15.235] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:15.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:95:0) after 1m0s
[04:31:15.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:95:0)
[04:31:15.256] Timer tick, asking Buildbucket for the build status
[04:31:15.400] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:15.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:96:0) after 1m0s
[04:32:15.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:96:0)
[04:32:15.470] Timer tick, asking Buildbucket for the build status
[04:32:15.868] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:15.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:97:0) after 1m0s
[04:33:16.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:97:0)
[04:33:16.019] Timer tick, asking Buildbucket for the build status
[04:33:16.164] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:16.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:98:0) after 1m0s
[04:34:16.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:98:0)
[04:34:16.194] Timer tick, asking Buildbucket for the build status
[04:34:16.841] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:16.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:99:0) after 1m0s
[04:35:16.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:99:0)
[04:35:16.907] Timer tick, asking Buildbucket for the build status
[04:35:16.972] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:16.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:100:0) after 1m0s
[04:36:17.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:100:0)
[04:36:17.095] Timer tick, asking Buildbucket for the build status
[04:36:17.181] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:17.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:101:0) after 1m0s
[04:37:17.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:101:0)
[04:37:17.268] Timer tick, asking Buildbucket for the build status
[04:37:17.358] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:17.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:102:0) after 1m0s
[04:38:17.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:102:0)
[04:38:17.407] Timer tick, asking Buildbucket for the build status
[04:38:17.953] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:17.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:103:0) after 1m0s
[04:39:18.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:103:0)
[04:39:18.106] Timer tick, asking Buildbucket for the build status
[04:39:18.192] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:18.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:104:0) after 1m0s
[04:40:18.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:104:0)
[04:40:18.296] Timer tick, asking Buildbucket for the build status
[04:40:18.378] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:18.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:105:0) after 1m0s
[04:41:18.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:105:0)
[04:41:18.471] Timer tick, asking Buildbucket for the build status
[04:41:18.839] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:18.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:106:0) after 1m0s
[04:42:18.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:106:0)
[04:42:18.943] Timer tick, asking Buildbucket for the build status
[04:42:19.319] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:19.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:107:0) after 1m0s
[04:43:19.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:107:0)
[04:43:19.510] Timer tick, asking Buildbucket for the build status
[04:43:19.652] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:19.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:108:0) after 1m0s
[04:44:19.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:108:0)
[04:44:19.777] Timer tick, asking Buildbucket for the build status
[04:44:19.908] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:19.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:109:0) after 1m0s
[04:45:19.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:109:0)
[04:45:19.995] Timer tick, asking Buildbucket for the build status
[04:45:20.062] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:20.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:110:0) after 1m0s
[04:46:20.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:110:0)
[04:46:20.104] Timer tick, asking Buildbucket for the build status
[04:46:20.478] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:20.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:111:0) after 1m0s
[04:47:20.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:111:0)
[04:47:20.558] Timer tick, asking Buildbucket for the build status
[04:47:20.631] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:20.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:112:0) after 1m0s
[04:48:20.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:112:0)
[04:48:20.722] Timer tick, asking Buildbucket for the build status
[04:48:20.848] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:20.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:113:0) after 1m0s
[04:49:20.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:113:0)
[04:49:20.899] Timer tick, asking Buildbucket for the build status
[04:49:21.373] Build 8865774621984886496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:21.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031204684261518416:114:0) after 1m0s
[04:50:01.938] Received PubSub notification, asking Buildbucket for the build status
[04:50:02.018] Build 8865774621984886496: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:50:02.019] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603342201406507",
"created_by": "project:chromium",
"created_ts": "1603335470174386",
"failure_reason": "BUILD_FAILURE",
"id": "8865774621984886496",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d5f1b896c259c0a2bf9768098be9de544f182bd7\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- CrostiniAppRestartDialogTest.OnlyHasOkButton\\n\\n- CrostiniAppRestartDialogTest.IsSystemModal\\n\\n- CrostiniAppRestartDialogTest.ContentsViewHasModalPreferredWidth\"}, \"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\": \"d5f1b896c259c0a2bf9768098be9de544f182bd7\", \"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-50-xkjg\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20957, \"got_angle_revision\": \"6029e464cf9306f110fb40d10467170e87b74a50\", \"got_dawn_revision\": \"22505a5afe1f75b402a00a27d49e313fbd6e2181\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"d5f1b896c259c0a2bf9768098be9de544f182bd7\", \"got_revision_cp\": \"refs/heads/master@{#819678}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"d9ccb94fc2738d2c7bec626c287518c5e3ad14e9\", \"got_v8_revision_cp\": \"refs/heads/8.8.149@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d5f1b896c259c0a2bf9768098be9de544f182bd7\", \"swarm_hashes_refs/heads/master(at){#819678}_without_patch\": {\"absl_hardening_tests\": \"1f2498c0c994ee0c54b3d7fbb5b06a9ca20dd906\", \"accessibility_unittests\": \"da189f2536ff7beb740a4dfb60a1012fa3c656f5\", \"app_list_unittests\": \"7a365229c65b2b8c0783b957a0d138115046b787\", \"app_shell_unittests\": \"08c303ad23278b3c8fff4a7ff3fb7793463fcfce\", \"ash_unittests\": \"12bb70d2a5e78d5eb739607a52662512378f6a09\", \"aura_unittests\": \"f333ef8b8c03ce4c142f191a4900f90b0ff0ba24\", \"base_unittests\": \"1ebc814cb0021f2dd0d7fe7a1cc39a2939c3ecf3\", \"base_util_unittests\": \"af19e488783b93c1f6c67f4a460af0934ce20521\", \"blink_common_unittests\": \"199bb60e56799f159c27e27e892e7dfc97275e94\", \"blink_fuzzer_unittests\": \"9c7bfceb7dfa693f50468f1dbdfd2a3a01d7331d\", \"blink_heap_unittests\": \"109f3b71b31a6faf1402c6e574591af7fdc60c98\", \"blink_platform_unittests\": \"99ae5509b3c34c51d88e0cdba7a51ebfcfff08ee\", \"blink_unittests\": \"50da65f2e48bd69155dc2b921e334ed7a471a20e\", \"boringssl_crypto_tests\": \"62eb2b90b21a5ac87a74b849fdf21203f9c81ff0\", \"boringssl_ssl_tests\": \"815d9aab7fea3a30615d842dbbf2f67c4400dac8\", \"browser_tests\": \"63691f0c280d28c43b2d282bc82d24532935b41a\", \"capture_unittests\": \"2885793d7116bbe71defbda4acf4b36c2f006038\", \"cast_unittests\": \"d54d560dd0f7324bf6f38951aad63fb7e2362fff\", \"cc_unittests\": \"6e74690bf3ca93768145d666128c02ba7a6b0103\", \"chrome_app_unittests\": \"2e807ac00975a128c302738027a182732bc663d2\", \"chromedriver_unittests\": \"c33197c75ead04aafdac83cfae0091ad6891e4ef\", \"chromeos_components_unittests\": \"158c58ec3fa72c2e478159533c1700c4f22e00e9\", \"chromeos_unittests\": \"38dfc102e4aab99ab1758f9c036d3ed5ab186dca\", \"components_browsertests\": \"91e112ee98267dcb240740380ea97f33fc882db2\", \"components_unittests\": \"47b7b44bc505edefa79a77a5b644176aa11d038e\", \"compositor_unittests\": \"8d407471a135948f11d6bd71b80a2b21fa4e5dfb\", \"content_browsertests\": \"1a8b52cee067dbbafd636046c5e3c021e1447adf\", \"content_unittests\": \"0679efdea733c6233419bba7f93e1c75d8686718\", \"crypto_unittests\": \"854b00160854b9c1b2b290ca2b93fa82056aac24\", \"dbus_unittests\": \"584d73c04bee01be8be96991b93c00a0ca98d19c\", \"device_unittests\": \"8edf2067898dd71001d0cfc5580cf1405c465a67\", \"display_unittests\": \"973644d8213804856ce10d6d110246212fffc3b1\", \"events_unittests\": \"af20e263a5530aed6a500985c6ac62d5f8460182\", \"exo_unittests\": \"192c4f0872eb765205cbb940b97a7a5a78bc7675\", \"extensions_browsertests\": \"70bf2f5ada177bc27291cc5ff30ac0d71d20e581\", \"extensions_unittests\": \"82d24ce88ec97de6261315f59adc561c5d2f85f4\", \"filesystem_service_unittests\": \"5a1a95e7f419e5015f70549c31ce97eb6a36a915\", \"gcm_unit_tests\": \"a6f033d275c68a923258e1b86137ca21e480d1b0\", \"gfx_unittests\": \"fed859c9d77ac500230388ac02c11b29898cf0a1\", \"gin_unittests\": \"ea15c93a2348530ae1303efd4c4fc73fccc6fbad\", \"gl_unittests_ozone\": \"fc434dfee277c68f65aeeafa287c7032a265fedd\", \"google_apis_unittests\": \"3445fe8017bdda09edd487ed0160b06e2b594fd5\", \"gpu_unittests\": \"7d5d0d0eb5c6923b5802cdfc08cb0d8724304655\", \"gwp_asan_unittests\": \"359027639c7b7b213e45e2454c21b2624fcdfdfa\", \"interactive_ui_tests\": \"743eefcdcf4d96fc891ef1b5e3b88e6762aef1b6\", \"ipc_tests\": \"15ba266dbc8f317d7dae9b3bdb0e1a4b765042dd\", \"jingle_unittests\": \"ad316f004b1697518aecc575e5840ff4844fa3f6\", \"keyboard_unittests\": \"16c7cc64f3f1fa0d01ed083e760744df013ddca2\", \"latency_unittests\": \"eef5923724bb94ad123e93eae1f7fb86dca33050\", \"libjingle_xmpp_unittests\": \"7e2a461e0265f8f7f3f8205852f46504c1110084\", \"media_blink_unittests\": \"41bea1dbe68d4171ac481fc455e012fdf3e1ad27\", \"media_unittests\": \"6a04feaf65f7eb808fb66ed274a1a88645693528\", \"message_center_unittests\": \"4470b170eb11f57ae122fbc58503c82f895f3ec3\", \"midi_unittests\": \"7e2e7adfeab5e318deda37edbb11fb44cd0e5ba1\", \"mojo_core_unittests\": \"a1fb8b4fc222e673455f11833155848f4d315885\", \"mojo_unittests\": \"419e68ca5951141242c1169d2ae4a6d702ce9156\", \"nacl_helper_nonsfi_unittests\": \"9b4258768fc0e991a7b1b2f8c37372c3915b8fd9\", \"nacl_loader_unittests\": \"85b8041ab7f8a2e358ded24291ef4f64f74e0f48\", \"native_theme_unittests\": \"027810306e86c00395265ad7b065508b55e6a638\", \"net_unittests\": \"fcf457d3ca6a7d4f53a81dbd46efcb456dab26d9\", \"ozone_gl_unittests\": \"ef53a5e7b09cd3fd84604dc57c63ba32255e7079\", \"ozone_unittests\": \"21824f88eea425529425ea10296f529ff22fde51\", \"ozone_x11_unittests\": \"3f402264876b44463c6a02bb67c528d29332013a\", \"pdf_unittests\": \"2d32b38cacaac2bbac3d2b19ab00b17b8891da4a\", \"perfetto_unittests\": \"a262e526ff221d35e80131e161978b282eb0d1b5\", \"ppapi_unittests\": \"fa9885e50487d5b8d6bf0b36d098a008530d7196\", \"printing_unittests\": \"97c707cecca219e60051e1b153599303d56865cb\", \"remoting_unittests\": \"5ab21bdb6098e44587ab15f092e75b47cdf2df9f\", \"sandbox_linux_unittests\": \"41cfa814d435a9c94cb91d094f85032b2ae5ca4a\", \"service_manager_unittests\": \"678a0b21b86f3830334555929eb24b503817aa80\", \"services_unittests\": \"bea1aacded29c16a5a723bb8d67e2b5fed7da546\", \"shell_dialogs_unittests\": \"2433a7c35867e6e4161d2e561e8dc78a4755aad4\", \"skia_unittests\": \"e7dd58211bc358d71b26b805968a73cd5cef5aa3\", \"snapshot_unittests\": \"ca25e56def01e502b91136cffb1ef393332c966c\", \"sql_unittests\": \"fd7132b81644de4d0dcbd32594565b6ec87d25f0\", \"standalone_angle_unittests\": \"a8a8fb17d94889c7dca2923c33e22f6b6c4674dc\", \"storage_unittests\": \"a56826693383eb809ddb69c06c2ef0c707a85a7e\", \"sync_integration_tests\": \"1649adbac29cec5228d5a84d87971683836a2420\", \"traffic_annotation_auditor_unittests\": \"e48267d55e10fae5d52da6c8d7b39cbaf947cb99\", \"ui_base_unittests\": \"4be79e32cdb9f35259ad35c2a0183682f3c0277a\", \"ui_chromeos_unittests\": \"e62150186872b5bd6dcdac80848ce7215ea68499\", \"ui_touch_selection_unittests\": \"231e8d4a8c179f68c41c19263e94104b1cc6e03f\", \"unit_tests\": \"69650a851b391ee2a4f9bc0d30a4e184c3ae4573\", \"url_unittests\": \"f2d0dc7266d7ba733fa3845417ee5419fe12f0f4\", \"usage_time_limit_unittests\": \"1e600173d5966632fd587540a5cda519d1b32ed4\", \"views_unittests\": \"ffa3878f335bb15f50715b100a278872816a12ae\", \"viz_unittests\": \"440ac01866d3199551febb9c56dc73eac4e76e7e\", \"wm_unittests\": \"26b0280cd24da5e33f4f607e6f45adfc1845bd60\", \"wtf_unittests\": \"ded76ac913b0079e9464a1d1e5c4a3708aa29db7\", \"zlib_unittests\": \"a8ef71e858f70fd2e54e4ca92db40108125161d0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-50-xkjg\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- CrostiniAppRestartDialogTest.OnlyHasOkButton\\n\\n- CrostiniAppRestartDialogTest.IsSystemModal\\n\\n- CrostiniAppRestartDialogTest.ContentsViewHasModalPreferredWidth\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603335724855420",
"status": "COMPLETED",
"status_changed_ts": "1603335725278450",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20957",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d5f1b896c259c0a2bf9768098be9de544f182bd7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d5f1b896c259c0a2bf9768098be9de544f182bd7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031204684261518416",
"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/8865774621984886496/+/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:4f670f47bd1ecb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603342201654590",
"url": "https://ci.chromium.org/b/8865774621984886496",
"utcnow_ts": "1603342202009733"
}
}
[04:50:02.019] Invocation finished in 1h52m13.399395297s with status FAILED