[20:02:02.294] New invocation is queued and will start shortly
[20:02:03.385] Starting the invocation (attempt 1)
[20:02:03.436] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:02:03.436] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:02:03.436] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031321439365046848",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"50006e40205617ffb1d7058ed587ecab5f3bbe92\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031321439365046848",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/50006e40205617ffb1d7058ed587ecab5f3bbe92",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/50006e40205617ffb1d7058ed587ecab5f3bbe92",
"gitiles_ref:refs/heads/master"
]
}
[20:02:04.395] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603224123564063",
"id": "8865891377368182096",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"50006e40205617ffb1d7058ed587ecab5f3bbe92\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603224124234063",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20938",
"builder:linux-chromeos-dbg",
"buildset:commit/git/50006e40205617ffb1d7058ed587ecab5f3bbe92",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/50006e40205617ffb1d7058ed587ecab5f3bbe92",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031321439365046848",
"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/8865891377368182096/+/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": "1603224124234182",
"url": "https://ci.chromium.org/b/8865891377368182096",
"utcnow_ts": "1603224124348524"
}
}
[20:02:04.395] Task URL: https://ci.chromium.org/b/8865891377368182096
[20:02:04.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:2:0) after 1m0s
[20:02:13.264] Received PubSub notification, asking Buildbucket for the build status
[20:02:13.345] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:04.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:2:0)
[20:03:04.481] Timer tick, asking Buildbucket for the build status
[20:03:05.284] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:05.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:4:0) after 1m0s
[20:04:05.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:4:0)
[20:04:05.338] Timer tick, asking Buildbucket for the build status
[20:04:05.504] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:05.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:5:0) after 1m0s
[20:05:05.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:5:0)
[20:05:05.527] Timer tick, asking Buildbucket for the build status
[20:05:05.647] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:05.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:6:0) after 1m0s
[20:06:05.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:6:0)
[20:06:05.744] Timer tick, asking Buildbucket for the build status
[20:06:05.924] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:05.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:7:0) after 1m0s
[20:07:05.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:7:0)
[20:07:05.945] Timer tick, asking Buildbucket for the build status
[20:07:06.577] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:06.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:8:0) after 1m0s
[20:08:06.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:8:0)
[20:08:06.642] Timer tick, asking Buildbucket for the build status
[20:08:06.931] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:06.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:9:0) after 1m0s
[20:09:07.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:9:0)
[20:09:07.012] Timer tick, asking Buildbucket for the build status
[20:09:07.083] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:07.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:10:0) after 1m0s
[20:10:07.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:10:0)
[20:10:07.082] Timer tick, asking Buildbucket for the build status
[20:10:07.283] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:07.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:11:0) after 1m0s
[20:11:07.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:11:0)
[20:11:07.371] Timer tick, asking Buildbucket for the build status
[20:11:08.121] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:08.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:12:0) after 1m0s
[20:12:08.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:12:0)
[20:12:08.197] Timer tick, asking Buildbucket for the build status
[20:12:08.261] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:08.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:13:0) after 1m0s
[20:13:08.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:13:0)
[20:13:08.288] Timer tick, asking Buildbucket for the build status
[20:13:08.441] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:08.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:14:0) after 1m0s
[20:14:08.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:14:0)
[20:14:08.486] Timer tick, asking Buildbucket for the build status
[20:14:08.547] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:08.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:15:0) after 1m0s
[20:15:08.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:15:0)
[20:15:08.557] Timer tick, asking Buildbucket for the build status
[20:15:08.821] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:08.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:16:0) after 1m0s
[20:16:08.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:16:0)
[20:16:08.810] Timer tick, asking Buildbucket for the build status
[20:16:09.085] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:09.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:17:0) after 1m0s
[20:17:09.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:17:0)
[20:17:09.129] Timer tick, asking Buildbucket for the build status
[20:17:09.211] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:09.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:18:0) after 1m0s
[20:18:09.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:18:0)
[20:18:09.295] Timer tick, asking Buildbucket for the build status
[20:18:09.399] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:09.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:19:0) after 1m0s
[20:19:09.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:19:0)
[20:19:09.483] Timer tick, asking Buildbucket for the build status
[20:19:09.702] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:09.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:20:0) after 1m0s
[20:20:09.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:20:0)
[20:20:09.725] Timer tick, asking Buildbucket for the build status
[20:20:09.785] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:09.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:21:0) after 1m0s
[20:21:09.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:21:0)
[20:21:09.819] Timer tick, asking Buildbucket for the build status
[20:21:09.881] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:09.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:22:0) after 1m0s
[20:22:09.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:22:0)
[20:22:09.991] Timer tick, asking Buildbucket for the build status
[20:22:10.199] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:10.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:23:0) after 1m0s
[20:23:10.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:23:0)
[20:23:10.320] Timer tick, asking Buildbucket for the build status
[20:23:10.422] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:10.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:24:0) after 1m0s
[20:24:10.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:24:0)
[20:24:10.474] Timer tick, asking Buildbucket for the build status
[20:24:10.579] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:10.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:25:0) after 1m0s
[20:25:10.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:25:0)
[20:25:10.621] Timer tick, asking Buildbucket for the build status
[20:25:10.689] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:10.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:26:0) after 1m0s
[20:26:10.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:26:0)
[20:26:10.746] Timer tick, asking Buildbucket for the build status
[20:26:10.811] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:10.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:27:0) after 1m0s
[20:27:11.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:27:0)
[20:27:11.028] Timer tick, asking Buildbucket for the build status
[20:27:11.087] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:11.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:28:0) after 1m0s
[20:28:11.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:28:0)
[20:28:11.184] Timer tick, asking Buildbucket for the build status
[20:28:12.117] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:12.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:29:0) after 1m0s
[20:29:12.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:29:0)
[20:29:12.186] Timer tick, asking Buildbucket for the build status
[20:29:12.245] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:12.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:30:0) after 1m0s
[20:30:12.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:30:0)
[20:30:12.437] Timer tick, asking Buildbucket for the build status
[20:30:12.524] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:12.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:31:0) after 1m0s
[20:31:12.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:31:0)
[20:31:12.645] Timer tick, asking Buildbucket for the build status
[20:31:12.730] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:12.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:32:0) after 1m0s
[20:32:12.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:32:0)
[20:32:12.767] Timer tick, asking Buildbucket for the build status
[20:32:12.843] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:12.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:33:0) after 1m0s
[20:33:12.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:33:0)
[20:33:12.955] Timer tick, asking Buildbucket for the build status
[20:33:13.121] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:13.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:34:0) after 1m0s
[20:34:13.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:34:0)
[20:34:13.145] Timer tick, asking Buildbucket for the build status
[20:34:13.366] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:13.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:35:0) after 1m0s
[20:35:13.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:35:0)
[20:35:13.456] Timer tick, asking Buildbucket for the build status
[20:35:13.573] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:13.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:36:0) after 1m0s
[20:36:13.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:36:0)
[20:36:13.716] Timer tick, asking Buildbucket for the build status
[20:36:13.828] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:13.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:37:0) after 1m0s
[20:37:13.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:37:0)
[20:37:13.813] Timer tick, asking Buildbucket for the build status
[20:37:13.950] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:13.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:38:0) after 1m0s
[20:38:13.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:38:0)
[20:38:13.925] Timer tick, asking Buildbucket for the build status
[20:38:14.099] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:14.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:39:0) after 1m0s
[20:39:14.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:39:0)
[20:39:14.156] Timer tick, asking Buildbucket for the build status
[20:39:14.217] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:14.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:40:0) after 1m0s
[20:40:14.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:40:0)
[20:40:14.320] Timer tick, asking Buildbucket for the build status
[20:40:14.393] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:14.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:41:0) after 1m0s
[20:41:14.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:41:0)
[20:41:14.400] Timer tick, asking Buildbucket for the build status
[20:41:14.516] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:42:0) after 1m0s
[20:42:14.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:42:0)
[20:42:14.574] Timer tick, asking Buildbucket for the build status
[20:42:15.319] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:15.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:43:0) after 1m0s
[20:43:15.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:43:0)
[20:43:15.347] Timer tick, asking Buildbucket for the build status
[20:43:15.464] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:15.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:44:0) after 1m0s
[20:44:15.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:44:0)
[20:44:15.463] Timer tick, asking Buildbucket for the build status
[20:44:15.580] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:15.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:45:0) after 1m0s
[20:45:15.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:45:0)
[20:45:15.641] Timer tick, asking Buildbucket for the build status
[20:45:16.013] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:16.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:46:0) after 1m0s
[20:46:16.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:46:0)
[20:46:16.038] Timer tick, asking Buildbucket for the build status
[20:46:16.170] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:16.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:47:0) after 1m0s
[20:47:16.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:47:0)
[20:47:16.188] Timer tick, asking Buildbucket for the build status
[20:47:16.323] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:16.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:48:0) after 1m0s
[20:48:16.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:48:0)
[20:48:16.356] Timer tick, asking Buildbucket for the build status
[20:48:16.463] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:16.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:49:0) after 1m0s
[20:49:16.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:49:0)
[20:49:16.507] Timer tick, asking Buildbucket for the build status
[20:49:16.605] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:16.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:50:0) after 1m0s
[20:50:16.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:50:0)
[20:50:16.656] Timer tick, asking Buildbucket for the build status
[20:50:17.509] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:17.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:51:0) after 1m0s
[20:51:17.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:51:0)
[20:51:17.580] Timer tick, asking Buildbucket for the build status
[20:51:17.717] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:17.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:52:0) after 1m0s
[20:52:17.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:52:0)
[20:52:17.821] Timer tick, asking Buildbucket for the build status
[20:52:18.026] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:18.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:53:0) after 1m0s
[20:53:18.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:53:0)
[20:53:18.037] Timer tick, asking Buildbucket for the build status
[20:53:18.102] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:18.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:54:0) after 1m0s
[20:54:18.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:54:0)
[20:54:18.134] Timer tick, asking Buildbucket for the build status
[20:54:18.500] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:18.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:55:0) after 1m0s
[20:55:18.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:55:0)
[20:55:18.527] Timer tick, asking Buildbucket for the build status
[20:55:18.680] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:18.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:56:0) after 1m0s
[20:56:18.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:56:0)
[20:56:18.762] Timer tick, asking Buildbucket for the build status
[20:56:19.898] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:19.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:57:0) after 1m0s
[20:57:19.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:57:0)
[20:57:19.898] Timer tick, asking Buildbucket for the build status
[20:57:20.036] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:20.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:58:0) after 1m0s
[20:58:20.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:58:0)
[20:58:20.101] Timer tick, asking Buildbucket for the build status
[20:58:20.172] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:20.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:59:0) after 1m0s
[20:59:20.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:59:0)
[20:59:20.234] Timer tick, asking Buildbucket for the build status
[20:59:20.309] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:20.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:60:0) after 1m0s
[21:00:20.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:60:0)
[21:00:20.361] Timer tick, asking Buildbucket for the build status
[21:00:20.476] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:20.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:61:0) after 1m0s
[21:01:20.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:61:0)
[21:01:20.515] Timer tick, asking Buildbucket for the build status
[21:01:20.668] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:20.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:62:0) after 1m0s
[21:02:20.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:62:0)
[21:02:20.798] Timer tick, asking Buildbucket for the build status
[21:02:21.521] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:21.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:63:0) after 1m0s
[21:03:21.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:63:0)
[21:03:21.593] Timer tick, asking Buildbucket for the build status
[21:03:21.983] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:21.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:64:0) after 1m0s
[21:04:22.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:64:0)
[21:04:22.069] Timer tick, asking Buildbucket for the build status
[21:04:22.189] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:22.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:65:0) after 1m0s
[21:05:22.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:65:0)
[21:05:22.244] Timer tick, asking Buildbucket for the build status
[21:05:22.933] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:22.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:66:0) after 1m0s
[21:06:22.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:66:0)
[21:06:22.986] Timer tick, asking Buildbucket for the build status
[21:06:23.103] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:23.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:67:0) after 1m0s
[21:07:23.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:67:0)
[21:07:23.179] Timer tick, asking Buildbucket for the build status
[21:07:23.801] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:23.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:68:0) after 1m0s
[21:08:23.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:68:0)
[21:08:23.909] Timer tick, asking Buildbucket for the build status
[21:08:24.044] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:24.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:69:0) after 1m0s
[21:09:24.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:69:0)
[21:09:24.091] Timer tick, asking Buildbucket for the build status
[21:09:24.182] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:24.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:70:0) after 1m0s
[21:10:25.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:70:0)
[21:10:25.005] Timer tick, asking Buildbucket for the build status
[21:10:25.082] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:25.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:71:0) after 1m0s
[21:11:25.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:71:0)
[21:11:25.165] Timer tick, asking Buildbucket for the build status
[21:11:26.093] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:26.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:72:0) after 1m0s
[21:12:26.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:72:0)
[21:12:26.143] Timer tick, asking Buildbucket for the build status
[21:12:26.302] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:26.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:73:0) after 1m0s
[21:13:26.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:73:0)
[21:13:26.297] Timer tick, asking Buildbucket for the build status
[21:13:26.603] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:26.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:74:0) after 1m0s
[21:14:26.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:74:0)
[21:14:26.628] Timer tick, asking Buildbucket for the build status
[21:14:26.830] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:26.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:75:0) after 1m0s
[21:15:26.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:75:0)
[21:15:26.873] Timer tick, asking Buildbucket for the build status
[21:15:27.016] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:27.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:76:0) after 1m0s
[21:16:27.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:76:0)
[21:16:27.054] Timer tick, asking Buildbucket for the build status
[21:16:27.126] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:27.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:77:0) after 1m0s
[21:17:27.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:77:0)
[21:17:27.186] Timer tick, asking Buildbucket for the build status
[21:17:27.490] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:27.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:78:0) after 1m0s
[21:18:27.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:78:0)
[21:18:27.535] Timer tick, asking Buildbucket for the build status
[21:18:27.700] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:27.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:79:0) after 1m0s
[21:19:27.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:79:0)
[21:19:27.728] Timer tick, asking Buildbucket for the build status
[21:19:27.856] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:27.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:80:0) after 1m0s
[21:20:27.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:80:0)
[21:20:27.887] Timer tick, asking Buildbucket for the build status
[21:20:28.308] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:28.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:81:0) after 1m0s
[21:21:28.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:81:0)
[21:21:28.327] Timer tick, asking Buildbucket for the build status
[21:21:28.403] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:28.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:82:0) after 1m0s
[21:22:28.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:82:0)
[21:22:28.427] Timer tick, asking Buildbucket for the build status
[21:22:28.595] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:28.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:83:0) after 1m0s
[21:23:28.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:83:0)
[21:23:28.624] Timer tick, asking Buildbucket for the build status
[21:23:28.720] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:28.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:84:0) after 1m0s
[21:24:28.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:84:0)
[21:24:28.753] Timer tick, asking Buildbucket for the build status
[21:24:29.099] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:29.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:85:0) after 1m0s
[21:25:29.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:85:0)
[21:25:29.177] Timer tick, asking Buildbucket for the build status
[21:25:29.393] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:29.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:86:0) after 1m0s
[21:26:29.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:86:0)
[21:26:29.406] Timer tick, asking Buildbucket for the build status
[21:26:30.274] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:30.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:87:0) after 1m0s
[21:27:30.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:87:0)
[21:27:30.353] Timer tick, asking Buildbucket for the build status
[21:27:30.468] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:30.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:88:0) after 1m0s
[21:28:30.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:88:0)
[21:28:30.516] Timer tick, asking Buildbucket for the build status
[21:28:30.607] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:30.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:89:0) after 1m0s
[21:29:30.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:89:0)
[21:29:30.653] Timer tick, asking Buildbucket for the build status
[21:29:30.733] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:30.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:90:0) after 1m0s
[21:30:30.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:90:0)
[21:30:30.762] Timer tick, asking Buildbucket for the build status
[21:30:30.992] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:30.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:91:0) after 1m0s
[21:31:31.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:91:0)
[21:31:31.090] Timer tick, asking Buildbucket for the build status
[21:31:31.161] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:31.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:92:0) after 1m0s
[21:32:31.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:92:0)
[21:32:31.219] Timer tick, asking Buildbucket for the build status
[21:32:31.394] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:31.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:93:0) after 1m0s
[21:33:31.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:93:0)
[21:33:31.461] Timer tick, asking Buildbucket for the build status
[21:33:31.556] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:31.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:94:0) after 1m0s
[21:34:31.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:94:0)
[21:34:31.615] Timer tick, asking Buildbucket for the build status
[21:34:31.688] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:31.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:95:0) after 1m0s
[21:35:31.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:95:0)
[21:35:31.741] Timer tick, asking Buildbucket for the build status
[21:35:31.852] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:31.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:96:0) after 1m0s
[21:36:31.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:96:0)
[21:36:31.888] Timer tick, asking Buildbucket for the build status
[21:36:31.988] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:31.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:97:0) after 1m0s
[21:37:32.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:97:0)
[21:37:32.135] Timer tick, asking Buildbucket for the build status
[21:37:32.384] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:32.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:98:0) after 1m0s
[21:38:32.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:98:0)
[21:38:32.510] Timer tick, asking Buildbucket for the build status
[21:38:32.624] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:32.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:99:0) after 1m0s
[21:39:32.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:99:0)
[21:39:32.633] Timer tick, asking Buildbucket for the build status
[21:39:32.806] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:32.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:100:0) after 1m0s
[21:40:32.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:100:0)
[21:40:32.883] Timer tick, asking Buildbucket for the build status
[21:40:32.991] Build 8865891377368182096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:32.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031321439365046848:101:0) after 1m0s
[21:40:54.319] Received PubSub notification, asking Buildbucket for the build status
[21:40:54.491] Build 8865891377368182096: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:40:54.491] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603230053612235",
"created_by": "project:chromium",
"created_ts": "1603224123564063",
"failure_reason": "BUILD_FAILURE",
"id": "8865891377368182096",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"50006e40205617ffb1d7058ed587ecab5f3bbe92\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- LoadTimingBrowserTest.HTTPS\"}, \"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\": \"50006e40205617ffb1d7058ed587ecab5f3bbe92\", \"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-17-tkzy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20938, \"got_angle_revision\": \"c55cd6b43d55fb0ed6e59a8a5c92be82258f5587\", \"got_dawn_revision\": \"e557087870b0db11f232ce5825f88d8037e10e7c\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"50006e40205617ffb1d7058ed587ecab5f3bbe92\", \"got_revision_cp\": \"refs/heads/master@{#819057}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"e874380dbb925517de67cba78f165a6fe6f44637\", \"got_v8_revision_cp\": \"refs/heads/8.8.141@{#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\": \"50006e40205617ffb1d7058ed587ecab5f3bbe92\", \"swarm_hashes_refs/heads/master(at){#819057}_without_patch\": {\"absl_hardening_tests\": \"dbee27afb86a82902d3265f94079b2f67c5fff0d\", \"accessibility_unittests\": \"e958f53c9edef49d3c4bd08e1862b5108d9b60be\", \"app_list_unittests\": \"c1754e7cf2c282246f489567c324a2156a94f3b8\", \"app_shell_unittests\": \"7fff2dea3c827b368bd013b7656f07e120d65c08\", \"ash_unittests\": \"f7c1445a006212e9ddad3c66209e17cb7fcb39fb\", \"aura_unittests\": \"ec829503c4ab269df23f8d974bc819e783a9c5d7\", \"base_unittests\": \"734b4db80b7d1b0115aa94734ab9eede757d67be\", \"base_util_unittests\": \"b2ae9d7f872338bdf9f7d6c74dacb6715b6f3c69\", \"blink_common_unittests\": \"cdb4f7641b7451025c6834694cebab0b3bb39d60\", \"blink_fuzzer_unittests\": \"c06ffe7bac60b12b3f570575907552b5c65d83c7\", \"blink_heap_unittests\": \"dd57b86559de4049f1185f0c96c8c57c91efbfe8\", \"blink_platform_unittests\": \"20b609a12c1d0dddc03b1726ce892f65a1ec68d1\", \"blink_unittests\": \"3b4b5b5061270ce79e3001a300d7887762f3d51b\", \"boringssl_crypto_tests\": \"61cabcca3449aa7efd39de6316aa65bc198de143\", \"boringssl_ssl_tests\": \"99031184340035cc836bd4e5774b64fc12608527\", \"browser_tests\": \"ae7d31f3649354b7ea04260e14bbc6c7c5eb7045\", \"capture_unittests\": \"7ff523194ed9761f5474639ac8a7a2f4db9548fd\", \"cast_unittests\": \"6038868f45e266263bf560d0a62566060199a4de\", \"cc_unittests\": \"4c85e669e8ec5637564467d0ce73d5998d3bd1d1\", \"chrome_app_unittests\": \"e71869555fa8ed669024e09968c6e0e06fe0a72c\", \"chromedriver_unittests\": \"be9882727452ac2dbcbfeacf8b84e565d7f5ec21\", \"chromeos_components_unittests\": \"5431d50abcb715a0f936ac2836fd96721d967dd3\", \"chromeos_unittests\": \"e0ed5f9c456a5e426b2f75321f3abacdaedf01a7\", \"components_browsertests\": \"97fb608aa48ac0ad7d90f5c5264aed370df24fce\", \"components_unittests\": \"901db9496d7443f97033777080b54f0d844af91f\", \"compositor_unittests\": \"d4e33b78fed70b5b2d3435e9ca9cd61180add802\", \"content_browsertests\": \"8cca03b8ca4f4de99c7887b659784ccd6317598f\", \"content_unittests\": \"0094258b0b920b77b8334458df281560c7a25406\", \"crypto_unittests\": \"5134f582d334c3525f6a1b0a9cfd54ffae84acca\", \"dbus_unittests\": \"03a01b75154450e347b8b5f882f5a2bb4d56d1e0\", \"device_unittests\": \"8ab7d346a676c517d8bf9f7f5f9607d5b9ab0da9\", \"display_unittests\": \"44d78351f4c3606b2a80a73058a06b2cf713112d\", \"events_unittests\": \"54c301eab4dcb19ab7a6d173770369cd942e1e38\", \"exo_unittests\": \"0d819e2f63b0260309d7effda4649b23c0c818d4\", \"extensions_browsertests\": \"8db00244487c0e29fea4ef87d5461e8062e2d69f\", \"extensions_unittests\": \"be74abb5a57ac18ba9681040b361a748d168cfee\", \"filesystem_service_unittests\": \"0be0eb94abce2743b8f95f10f38942b27a77fd8d\", \"gcm_unit_tests\": \"896affe4f86cbeb6101f6abd18a5218232172b59\", \"gfx_unittests\": \"cb1778cf8ea12110cb81aed4cebd1ba00ae7df23\", \"gin_unittests\": \"937cc11589e367907cbcbd0572c743f08bf535c1\", \"gl_unittests_ozone\": \"4cbd77c7b46937856fca54524dd0d3417b70111c\", \"google_apis_unittests\": \"3460c6fd25726698613de368c9fa61d9aea0a45c\", \"gpu_unittests\": \"392f96727577c9f03c1d79c9d646701eb93f1fe2\", \"gwp_asan_unittests\": \"c144693cdb999082a213aae87d6efc3b3ee0fa81\", \"interactive_ui_tests\": \"f4339c40b1e8b30eef06cb76a1f2e1c5b2b5f89b\", \"ipc_tests\": \"e1a6f0ef67d00583d98f85261cdb5066de1392d3\", \"jingle_unittests\": \"3dc42c213e1cafe4a51e7f1b44cfa0097588e43f\", \"keyboard_unittests\": \"855ea2f74379003da49422ed6f30abca98da3f15\", \"latency_unittests\": \"ec30e56f1e09a25b3a59138899669e48bdc6c8c0\", \"libjingle_xmpp_unittests\": \"f5564a03ff28e051e331ab29d50118c75f9853cc\", \"media_blink_unittests\": \"fdaf2ef193b2e21591ae52fd6ac932baf3fe6d12\", \"media_unittests\": \"5d969a54a2586e02df9181ad4adda1cbd8729b14\", \"message_center_unittests\": \"1918b8ca635b44ed6d404c50a6c391f2be581ede\", \"midi_unittests\": \"ff891156adedf6843d196d0d2f6ff78f477b0632\", \"mojo_core_unittests\": \"daa23eb86c3a0ab60b9c6bf6365ee618d2e4515a\", \"mojo_unittests\": \"d013473e1bc1451740ac85439512513b98122845\", \"nacl_helper_nonsfi_unittests\": \"c1b93ba6fe19b6d3f592c9e99d7ac2211655d8b1\", \"nacl_loader_unittests\": \"0b9aad58ea90561e25d82fa849b944047af7e064\", \"native_theme_unittests\": \"3cfd936e71bc04c12e654380bc04d053d024636b\", \"net_unittests\": \"9f3fc6ca46ad023f8d76bbe475ba91d99552ac36\", \"ozone_gl_unittests\": \"e380b64afb1732c7d53f729041b8fa0130ccdfd2\", \"ozone_unittests\": \"27cab3153397d964d33c10b23790b3a5cc1f7a9a\", \"ozone_x11_unittests\": \"dab6e64edc9f6940218dac16c30d9b9da27e8dbe\", \"pdf_unittests\": \"292bce81bc432753a267424d96449e983046dfe5\", \"perfetto_unittests\": \"ac31c38710b5f118a903c9152603f9db3c92b49d\", \"ppapi_unittests\": \"9efd09bbaa32c08f56d7626cb3a4bf169addbb0b\", \"printing_unittests\": \"1c5ef29ab216bf1edefa08ac7662a6e4fd28968a\", \"remoting_unittests\": \"32a383c2c9319c871be4272fd243a1d53cd91088\", \"sandbox_linux_unittests\": \"7d1ed248181ac12bbb2c013b8867c2e24d0fb4ec\", \"service_manager_unittests\": \"f6f46e2629841714948ab600a2fb4ef36e944614\", \"services_unittests\": \"494ade6fa25d5500ed890931e41b099b5f8f4281\", \"shell_dialogs_unittests\": \"1e2f09a3ec53abe7f260509ea0cb0e70e51c0ed3\", \"skia_unittests\": \"5aff6e1a8b59579410c9ebf2d8c41445011087e3\", \"snapshot_unittests\": \"c16fcb7d45c0e2f5fb13b180076d5038118b373b\", \"sql_unittests\": \"c889334cd622926e18826ab9a2c75be7c9c4f067\", \"standalone_angle_unittests\": \"65c3faa952ae594b79c2c76838d5daaa6f55457b\", \"storage_unittests\": \"60028e615152fed88c2be21429e0cd02b758c265\", \"sync_integration_tests\": \"e62350d6b58249fa4c2aa879c51776c70dde43fa\", \"traffic_annotation_auditor_unittests\": \"9d29ba1e3e35361f1205d9738469931bfbbc9b5c\", \"ui_base_unittests\": \"31816147330f4c698f518f8882d8fadc7086678c\", \"ui_chromeos_unittests\": \"56072175bc000e0f2462480013c59930274a739d\", \"ui_touch_selection_unittests\": \"44a0ba7ff9f0f03cf0b6cc01f67f747a977e4fc9\", \"unit_tests\": \"896435a6459bbd95a2299e093fd2299e89950a50\", \"url_unittests\": \"b1514976a01c6a432149fdcd3d05f878eaa9a5fa\", \"usage_time_limit_unittests\": \"2428b95c507290d5e46776c0c643925dc96d2abc\", \"views_unittests\": \"7df7526d84f0a2e61b547edc96d8bae13355c5cd\", \"viz_unittests\": \"1f1bbd75a0fe442aa5afb1ed5efaa957b983510a\", \"wm_unittests\": \"a1f85dfdbeed4fcb8b6ca5878dd360a056df3cbd\", \"wtf_unittests\": \"15a89526bcf8642e3381077463fa73475eb7b6dc\", \"zlib_unittests\": \"2635f1414f3270eb765f9edcb08150191fd1b586\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06bf165a3bf7a25e93955b74ebaf013d13a4a87ad7bcb716437f8a47afa74d09_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_9d393496fc50bd2ba7e16167b6377b317d5cb146b2dfdb60405146db5a374eac_v2\", \"builder_ebb06fb409ef3255b3561ad6bc0df7706a15849e85ba50b708bdfb917530d411_v2\", \"builder_f72b88ee7914fe5eb8b32d979ad6b47003d3a0322a10970d43d78c86a32dd14e_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-17-tkzy\"], \"image\": [\"chrome-xenial-20101301-f14f52fdd71\"], \"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**browser_tests** failed because of:\\n\\n- LoadTimingBrowserTest.HTTPS\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603224131414196",
"status": "COMPLETED",
"status_changed_ts": "1603224132827613",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20938",
"builder:linux-chromeos-dbg",
"buildset:commit/git/50006e40205617ffb1d7058ed587ecab5f3bbe92",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/50006e40205617ffb1d7058ed587ecab5f3bbe92",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031321439365046848",
"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/8865891377368182096/+/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:4f606c5cb6598d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603230053857280",
"url": "https://ci.chromium.org/b/8865891377368182096",
"utcnow_ts": "1603230054480389"
}
}
[21:40:54.491] Invocation finished in 1h38m52.214917858s with status FAILED