[11:13:41.402] New invocation is queued and will start shortly
[11:13:42.564] Starting the invocation (attempt 1)
[11:13:42.610] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:13:42.610] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:13:42.610] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028727368136473424",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2e87369b839558e498fb3a33593b72598c2c5433\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028727368136473424",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/2e87369b839558e498fb3a33593b72598c2c5433",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e87369b839558e498fb3a33593b72598c2c5433",
"gitiles_ref:refs/heads/master"
]
}
[11:13:44.614] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605698022808428",
"id": "8863297305994134256",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e87369b839558e498fb3a33593b72598c2c5433\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605698024268543",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21367",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2e87369b839558e498fb3a33593b72598c2c5433",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e87369b839558e498fb3a33593b72598c2c5433",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028727368136473424",
"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/8863297305994134256/+/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": "1605698024268746",
"url": "https://ci.chromium.org/b/8863297305994134256",
"utcnow_ts": "1605698024590749"
}
}
[11:13:44.614] Task URL: https://ci.chromium.org/b/8863297305994134256
[11:13:44.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:2:0) after 1m0s
[11:13:47.335] Received PubSub notification, asking Buildbucket for the build status
[11:13:47.408] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:44.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:2:0)
[11:14:44.771] Timer tick, asking Buildbucket for the build status
[11:14:45.298] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:45.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:4:0) after 1m0s
[11:15:45.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:4:0)
[11:15:45.405] Timer tick, asking Buildbucket for the build status
[11:15:45.457] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:45.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:5:0) after 1m0s
[11:16:45.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:5:0)
[11:16:45.553] Timer tick, asking Buildbucket for the build status
[11:16:45.686] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:45.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:6:0) after 1m0s
[11:17:45.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:6:0)
[11:17:45.758] Timer tick, asking Buildbucket for the build status
[11:17:46.227] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:46.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:7:0) after 1m0s
[11:18:46.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:7:0)
[11:18:46.366] Timer tick, asking Buildbucket for the build status
[11:18:46.468] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:46.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:8:0) after 1m0s
[11:19:46.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:8:0)
[11:19:46.637] Timer tick, asking Buildbucket for the build status
[11:19:47.276] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:47.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:9:0) after 1m0s
[11:20:47.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:9:0)
[11:20:47.385] Timer tick, asking Buildbucket for the build status
[11:20:47.496] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:47.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:10:0) after 1m0s
[11:21:47.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:10:0)
[11:21:47.570] Timer tick, asking Buildbucket for the build status
[11:21:47.715] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:47.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:11:0) after 1m0s
[11:22:47.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:11:0)
[11:22:47.855] Timer tick, asking Buildbucket for the build status
[11:22:47.945] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:47.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:12:0) after 1m0s
[11:23:48.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:12:0)
[11:23:48.081] Timer tick, asking Buildbucket for the build status
[11:23:48.258] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:48.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:13:0) after 1m0s
[11:24:48.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:13:0)
[11:24:48.436] Timer tick, asking Buildbucket for the build status
[11:24:48.512] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:48.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:14:0) after 1m0s
[11:25:49.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:14:0)
[11:25:49.109] Timer tick, asking Buildbucket for the build status
[11:25:49.175] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:49.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:15:0) after 1m0s
[11:26:49.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:15:0)
[11:26:49.551] Timer tick, asking Buildbucket for the build status
[11:26:49.617] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:49.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:16:0) after 1m0s
[11:27:49.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:16:0)
[11:27:49.850] Timer tick, asking Buildbucket for the build status
[11:27:49.911] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:49.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:17:0) after 1m0s
[11:28:50.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:17:0)
[11:28:50.073] Timer tick, asking Buildbucket for the build status
[11:28:50.203] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:50.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:18:0) after 1m0s
[11:29:50.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:18:0)
[11:29:50.521] Timer tick, asking Buildbucket for the build status
[11:29:50.594] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:50.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:19:0) after 1m0s
[11:30:50.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:19:0)
[11:30:50.781] Timer tick, asking Buildbucket for the build status
[11:30:50.871] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:50.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:20:0) after 1m0s
[11:31:50.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:20:0)
[11:31:50.947] Timer tick, asking Buildbucket for the build status
[11:31:51.016] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:51.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:21:0) after 1m0s
[11:32:51.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:21:0)
[11:32:51.064] Timer tick, asking Buildbucket for the build status
[11:32:51.130] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:51.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:22:0) after 1m0s
[11:33:51.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:22:0)
[11:33:51.224] Timer tick, asking Buildbucket for the build status
[11:33:51.328] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:51.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:23:0) after 1m0s
[11:34:51.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:23:0)
[11:34:51.383] Timer tick, asking Buildbucket for the build status
[11:34:51.456] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:51.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:24:0) after 1m0s
[11:35:51.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:24:0)
[11:35:51.494] Timer tick, asking Buildbucket for the build status
[11:35:51.566] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:51.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:25:0) after 1m0s
[11:36:51.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:25:0)
[11:36:51.549] Timer tick, asking Buildbucket for the build status
[11:36:51.692] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:51.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:26:0) after 1m0s
[11:37:51.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:26:0)
[11:37:51.826] Timer tick, asking Buildbucket for the build status
[11:37:51.947] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:51.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:27:0) after 1m0s
[11:38:51.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:27:0)
[11:38:51.944] Timer tick, asking Buildbucket for the build status
[11:38:52.053] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:52.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:28:0) after 1m0s
[11:39:52.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:28:0)
[11:39:52.176] Timer tick, asking Buildbucket for the build status
[11:39:52.308] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:52.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:29:0) after 1m0s
[11:40:52.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:29:0)
[11:40:52.382] Timer tick, asking Buildbucket for the build status
[11:40:52.500] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:52.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:30:0) after 1m0s
[11:41:52.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:30:0)
[11:41:52.573] Timer tick, asking Buildbucket for the build status
[11:41:52.650] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:52.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:31:0) after 1m0s
[11:42:52.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:31:0)
[11:42:52.864] Timer tick, asking Buildbucket for the build status
[11:42:52.925] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:52.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:32:0) after 1m0s
[11:43:53.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:32:0)
[11:43:53.067] Timer tick, asking Buildbucket for the build status
[11:43:53.316] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:53.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:33:0) after 1m0s
[11:44:53.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:33:0)
[11:44:53.359] Timer tick, asking Buildbucket for the build status
[11:44:53.436] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:53.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:34:0) after 1m0s
[11:45:53.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:34:0)
[11:45:53.521] Timer tick, asking Buildbucket for the build status
[11:45:53.624] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:53.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:35:0) after 1m0s
[11:46:53.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:35:0)
[11:46:53.690] Timer tick, asking Buildbucket for the build status
[11:46:53.797] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:53.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:36:0) after 1m0s
[11:47:54.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:36:0)
[11:47:54.164] Timer tick, asking Buildbucket for the build status
[11:47:54.228] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:54.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:37:0) after 1m0s
[11:48:54.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:37:0)
[11:48:54.270] Timer tick, asking Buildbucket for the build status
[11:48:54.364] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:54.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:38:0) after 1m0s
[11:49:54.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:38:0)
[11:49:54.521] Timer tick, asking Buildbucket for the build status
[11:49:54.617] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:54.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:39:0) after 1m0s
[11:50:54.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:39:0)
[11:50:54.642] Timer tick, asking Buildbucket for the build status
[11:50:54.708] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:54.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:40:0) after 1m0s
[11:51:54.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:40:0)
[11:51:54.727] Timer tick, asking Buildbucket for the build status
[11:51:54.782] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:54.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:41:0) after 1m0s
[11:52:54.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:41:0)
[11:52:54.834] Timer tick, asking Buildbucket for the build status
[11:52:54.900] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:54.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:42:0) after 1m0s
[11:53:55.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:42:0)
[11:53:55.137] Timer tick, asking Buildbucket for the build status
[11:53:55.327] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:55.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:43:0) after 1m0s
[11:54:55.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:43:0)
[11:54:55.495] Timer tick, asking Buildbucket for the build status
[11:54:55.664] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:55.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:44:0) after 1m0s
[11:55:55.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:44:0)
[11:55:55.735] Timer tick, asking Buildbucket for the build status
[11:55:55.793] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:55.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:45:0) after 1m0s
[11:56:55.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:45:0)
[11:56:55.909] Timer tick, asking Buildbucket for the build status
[11:56:56.043] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:56.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:46:0) after 1m0s
[11:57:56.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:46:0)
[11:57:56.101] Timer tick, asking Buildbucket for the build status
[11:57:56.230] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:56.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:47:0) after 1m0s
[11:58:56.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:47:0)
[11:58:56.269] Timer tick, asking Buildbucket for the build status
[11:58:56.372] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:56.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:48:0) after 1m0s
[11:59:56.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:48:0)
[11:59:56.412] Timer tick, asking Buildbucket for the build status
[11:59:56.533] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:56.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:49:0) after 1m0s
[12:00:56.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:49:0)
[12:00:56.560] Timer tick, asking Buildbucket for the build status
[12:00:56.651] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:56.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:50:0) after 1m0s
[12:01:56.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:50:0)
[12:01:56.710] Timer tick, asking Buildbucket for the build status
[12:01:56.929] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:56.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:51:0) after 1m0s
[12:02:57.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:51:0)
[12:02:57.028] Timer tick, asking Buildbucket for the build status
[12:02:57.150] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:57.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:52:0) after 1m0s
[12:03:57.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:52:0)
[12:03:57.251] Timer tick, asking Buildbucket for the build status
[12:03:57.840] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:57.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:53:0) after 1m0s
[12:04:57.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:53:0)
[12:04:57.922] Timer tick, asking Buildbucket for the build status
[12:04:58.108] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:58.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:54:0) after 1m0s
[12:05:58.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:54:0)
[12:05:58.216] Timer tick, asking Buildbucket for the build status
[12:05:58.366] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:58.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:55:0) after 1m0s
[12:06:58.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:55:0)
[12:06:58.458] Timer tick, asking Buildbucket for the build status
[12:06:59.003] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:59.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:56:0) after 1m0s
[12:07:59.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:56:0)
[12:07:59.084] Timer tick, asking Buildbucket for the build status
[12:08:00.733] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:00.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:57:0) after 1m0s
[12:09:00.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:57:0)
[12:09:00.803] Timer tick, asking Buildbucket for the build status
[12:09:01.104] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:01.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:58:0) after 1m0s
[12:10:01.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:58:0)
[12:10:01.282] Timer tick, asking Buildbucket for the build status
[12:10:01.784] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:01.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:59:0) after 1m0s
[12:11:01.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:59:0)
[12:11:01.870] Timer tick, asking Buildbucket for the build status
[12:11:02.217] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:02.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:60:0) after 1m0s
[12:12:02.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:60:0)
[12:12:02.312] Timer tick, asking Buildbucket for the build status
[12:12:02.641] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:02.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:61:0) after 1m0s
[12:13:02.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:61:0)
[12:13:02.653] Timer tick, asking Buildbucket for the build status
[12:13:03.199] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:03.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:62:0) after 1m0s
[12:14:03.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:62:0)
[12:14:03.226] Timer tick, asking Buildbucket for the build status
[12:14:03.374] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:03.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:63:0) after 1m0s
[12:15:03.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:63:0)
[12:15:03.417] Timer tick, asking Buildbucket for the build status
[12:15:04.306] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:04.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:64:0) after 1m0s
[12:16:04.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:64:0)
[12:16:04.352] Timer tick, asking Buildbucket for the build status
[12:16:04.464] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:04.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:65:0) after 1m0s
[12:17:04.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:65:0)
[12:17:04.502] Timer tick, asking Buildbucket for the build status
[12:17:04.570] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:04.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:66:0) after 1m0s
[12:18:04.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:66:0)
[12:18:04.679] Timer tick, asking Buildbucket for the build status
[12:18:04.753] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:04.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:67:0) after 1m0s
[12:19:04.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:67:0)
[12:19:04.766] Timer tick, asking Buildbucket for the build status
[12:19:04.892] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:04.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:68:0) after 1m0s
[12:20:04.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:68:0)
[12:20:04.968] Timer tick, asking Buildbucket for the build status
[12:20:05.045] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:05.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:69:0) after 1m0s
[12:21:05.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:69:0)
[12:21:05.092] Timer tick, asking Buildbucket for the build status
[12:21:05.987] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:05.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:70:0) after 1m0s
[12:22:06.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:70:0)
[12:22:06.036] Timer tick, asking Buildbucket for the build status
[12:22:06.175] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:06.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:71:0) after 1m0s
[12:23:06.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:71:0)
[12:23:06.240] Timer tick, asking Buildbucket for the build status
[12:23:06.348] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:06.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:72:0) after 1m0s
[12:24:06.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:72:0)
[12:24:06.501] Timer tick, asking Buildbucket for the build status
[12:24:06.621] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:06.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:73:0) after 1m0s
[12:25:06.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:73:0)
[12:25:06.751] Timer tick, asking Buildbucket for the build status
[12:25:06.987] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:06.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:74:0) after 1m0s
[12:26:07.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:74:0)
[12:26:07.086] Timer tick, asking Buildbucket for the build status
[12:26:07.230] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:07.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:75:0) after 1m0s
[12:27:07.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:75:0)
[12:27:07.323] Timer tick, asking Buildbucket for the build status
[12:27:07.409] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:07.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:76:0) after 1m0s
[12:28:07.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:76:0)
[12:28:07.481] Timer tick, asking Buildbucket for the build status
[12:28:07.558] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:07.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:77:0) after 1m0s
[12:29:07.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:77:0)
[12:29:07.638] Timer tick, asking Buildbucket for the build status
[12:29:07.739] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:07.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:78:0) after 1m0s
[12:30:07.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:78:0)
[12:30:07.844] Timer tick, asking Buildbucket for the build status
[12:30:07.934] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:07.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:79:0) after 1m0s
[12:31:08.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:79:0)
[12:31:08.039] Timer tick, asking Buildbucket for the build status
[12:31:08.201] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:08.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:80:0) after 1m0s
[12:32:08.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:80:0)
[12:32:08.300] Timer tick, asking Buildbucket for the build status
[12:32:08.660] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:08.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:81:0) after 1m0s
[12:33:09.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:81:0)
[12:33:09.150] Timer tick, asking Buildbucket for the build status
[12:33:09.241] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:09.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:82:0) after 1m0s
[12:34:09.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:82:0)
[12:34:09.409] Timer tick, asking Buildbucket for the build status
[12:34:09.839] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:09.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:83:0) after 1m0s
[12:35:09.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:83:0)
[12:35:09.969] Timer tick, asking Buildbucket for the build status
[12:35:10.098] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:10.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:84:0) after 1m0s
[12:36:10.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:84:0)
[12:36:10.296] Timer tick, asking Buildbucket for the build status
[12:36:10.594] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:10.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:85:0) after 1m0s
[12:37:10.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:85:0)
[12:37:10.855] Timer tick, asking Buildbucket for the build status
[12:37:10.950] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:10.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:86:0) after 1m0s
[12:38:11.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:86:0)
[12:38:11.202] Timer tick, asking Buildbucket for the build status
[12:38:11.489] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:11.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:87:0) after 1m0s
[12:39:11.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:87:0)
[12:39:11.659] Timer tick, asking Buildbucket for the build status
[12:39:11.793] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:11.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:88:0) after 1m0s
[12:40:11.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:88:0)
[12:40:11.885] Timer tick, asking Buildbucket for the build status
[12:40:11.957] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:11.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:89:0) after 1m0s
[12:41:11.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:89:0)
[12:41:11.997] Timer tick, asking Buildbucket for the build status
[12:41:12.112] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:12.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:90:0) after 1m0s
[12:42:12.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:90:0)
[12:42:12.383] Timer tick, asking Buildbucket for the build status
[12:42:12.537] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:12.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:91:0) after 1m0s
[12:43:12.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:91:0)
[12:43:12.626] Timer tick, asking Buildbucket for the build status
[12:43:12.744] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:12.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:92:0) after 1m0s
[12:44:12.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:92:0)
[12:44:12.933] Timer tick, asking Buildbucket for the build status
[12:44:13.060] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:13.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:93:0) after 1m0s
[12:45:13.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:93:0)
[12:45:13.126] Timer tick, asking Buildbucket for the build status
[12:45:13.332] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:13.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:94:0) after 1m0s
[12:46:13.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:94:0)
[12:46:13.422] Timer tick, asking Buildbucket for the build status
[12:46:13.613] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:13.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:95:0) after 1m0s
[12:47:13.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:95:0)
[12:47:13.638] Timer tick, asking Buildbucket for the build status
[12:47:13.702] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:13.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:96:0) after 1m0s
[12:48:13.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:96:0)
[12:48:13.770] Timer tick, asking Buildbucket for the build status
[12:48:13.836] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:13.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:97:0) after 1m0s
[12:49:13.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:97:0)
[12:49:13.878] Timer tick, asking Buildbucket for the build status
[12:49:15.468] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:15.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:98:0) after 1m0s
[12:50:15.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:98:0)
[12:50:15.560] Timer tick, asking Buildbucket for the build status
[12:50:15.682] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:15.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:99:0) after 1m0s
[12:51:15.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:99:0)
[12:51:15.758] Timer tick, asking Buildbucket for the build status
[12:51:15.871] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:15.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:100:0) after 1m0s
[12:52:15.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:100:0)
[12:52:15.955] Timer tick, asking Buildbucket for the build status
[12:52:16.095] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:16.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:101:0) after 1m0s
[12:53:16.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:101:0)
[12:53:16.190] Timer tick, asking Buildbucket for the build status
[12:53:16.413] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:16.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:102:0) after 1m0s
[12:54:16.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:102:0)
[12:54:16.525] Timer tick, asking Buildbucket for the build status
[12:54:16.658] Build 8863297305994134256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:16.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028727368136473424:103:0) after 1m0s
[12:55:11.584] Received PubSub notification, asking Buildbucket for the build status
[12:55:11.711] Build 8863297305994134256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:55:11.711] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605704110772999",
"created_by": "project:chromium",
"created_ts": "1605698022808428",
"id": "8863297305994134256",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e87369b839558e498fb3a33593b72598c2c5433\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"2e87369b839558e498fb3a33593b72598c2c5433\", \"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-central1-b-8-21-5opr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21367, \"got_angle_revision\": \"2ffff6d024c7d639ecf4258402c2d047bb09588a\", \"got_dawn_revision\": \"a0758a1aef12b02216c2df2781d8e1458d6d7da6\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"2e87369b839558e498fb3a33593b72598c2c5433\", \"got_revision_cp\": \"refs/heads/master@{#828664}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"bb96f79d0e15daa9af7b11b2868baeb052d136d9\", \"got_v8_revision\": \"3644d1fc3b7f59e11f5e80b6feb79634736e0192\", \"got_v8_revision_cp\": \"refs/heads/8.9.7@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e87369b839558e498fb3a33593b72598c2c5433\", \"swarm_hashes_refs/heads/master(at){#828664}_without_patch\": {\"absl_hardening_tests\": \"f6d835481adb07719d98c3c82724561290408781\", \"accessibility_unittests\": \"29a4bd9cecf211b76239f3031bc673b95cf209b1\", \"angle_unittests\": \"9380c86d1cabb82f6c585624004b1d1c197e6363\", \"app_list_unittests\": \"e21dc581f12f2e23178fa64bc962f7da5f3fed4c\", \"app_shell_unittests\": \"326d1d42488f1e3ccc06bc7f996ba87895d816f5\", \"ash_unittests\": \"bb8699df01480568ffd9812db1a6214ffbe6b5b1\", \"aura_unittests\": \"e33b9ca38810a9914e6292ba301a9e26b77092cd\", \"base_unittests\": \"5217dfe21223ebb8f421632b928ba89e993905db\", \"base_util_unittests\": \"4237f3b88c74aa7b69a93e03c9facb95e14d5a11\", \"blink_common_unittests\": \"1450119bcc58f2306a70a94c7beb60a7c5c52662\", \"blink_fuzzer_unittests\": \"b08e0144cc26b8e28d256411c7ef377e0e0bb6c3\", \"blink_heap_unittests\": \"1488c5920a002dfa6fc25dee2605885ba8f05bbd\", \"blink_platform_unittests\": \"d4ed733e55b389d76d7df6b609ba53baa4c7b440\", \"blink_unittests\": \"880e8052285b796f820c4dd0653527d4ca745577\", \"boringssl_crypto_tests\": \"cbaac101c2f9d6b18600ea7bf6076ada03b4bb7a\", \"boringssl_ssl_tests\": \"c033eff85e0945e82b33b851fd61d5a1dda3ac3b\", \"browser_tests\": \"0e6623d010bc4f6cc9275faddc4c66ae103de476\", \"capture_unittests\": \"ebbd11ef3966a71185bfba011af4121d6db12b81\", \"cast_unittests\": \"b212665cddd9c064bd57fd477399c2f04b6c23ba\", \"cc_unittests\": \"671f191f641eb6544afa3f189fb1551577424abf\", \"chrome_app_unittests\": \"fa9ecba46f8d8a2fe8caa376e4b5b3e397dcc275\", \"chromedriver_unittests\": \"32acf0de51d063bc4efc2e009af8138ee9b11319\", \"chromeos_components_unittests\": \"459329347c6a2cc0af30795263a745bf65a1bd7d\", \"chromeos_unittests\": \"a0e6386b6e4bb9a58bb9c4fd82e12a34bda12726\", \"components_browsertests\": \"aeb2d9625e9574d90cf4c196afdf15298c711075\", \"components_unittests\": \"369e950a01524c8e2d977824332cb89449a101c0\", \"compositor_unittests\": \"ff5709d5a912c03028d73d01921af3d5402c805f\", \"content_browsertests\": \"d9f6ad089a130eb30c08aaec2a15ff60579238d8\", \"content_unittests\": \"b903c598de49e1fd876cee77aca8aeb91f60ad73\", \"crashpad_tests\": \"2ee1575dd8dfe17198270a0089874412c3996c5f\", \"crypto_unittests\": \"d774f4d977eadc406841d00a125d39a2ea27576f\", \"dbus_unittests\": \"c94a40095d5129eeabe515e9192e4db62536ab91\", \"device_unittests\": \"ddc15657525afe209210013e0a01b9e0b4eaa502\", \"display_unittests\": \"fd3c1b7c60b11f5ef89b0b7b3c3649c2a39bb70a\", \"events_unittests\": \"3e44183d5bffa5e4d76a9175784693e937c73a5b\", \"exo_unittests\": \"11fe4f7f7f68170dc1cd431a6dc2f93c409e01a6\", \"extensions_browsertests\": \"3a7510a00b3ec1c854bc12cbc5b3476cba24f40e\", \"extensions_unittests\": \"533abedb19832ef7af97b83204556dc4ae778655\", \"filesystem_service_unittests\": \"bd9fa9d14540d625424bf4646a23a36e1e9c59ee\", \"gcm_unit_tests\": \"ed9ba989c958c9ffda7cf9a4dbea37348bfd1367\", \"gfx_unittests\": \"4d543290608d620a88edccc358106f2960115aed\", \"gin_unittests\": \"bb77551ad47b6f942eb0c9d5e5908385a26dda8e\", \"gl_unittests_ozone\": \"b688007b2afc1abcf1508cc40e969f8a9c5422ed\", \"google_apis_unittests\": \"f5e3dd22c59315158679e0dbefa952c1d815e49b\", \"gpu_unittests\": \"b354934569811725eb2e4b0fdfd254d3c43619ee\", \"gwp_asan_unittests\": \"370a4a3421560bd0a648fb24793e3c204571c05f\", \"interactive_ui_tests\": \"c935b3d3c03e949f59af0abb17edc46334d22053\", \"ipc_tests\": \"1955edd97229084c817c3b245186232044fc3699\", \"jingle_unittests\": \"91e77282a116b4afb18148a3e3958337cb44e254\", \"keyboard_unittests\": \"714f752e9e98f1e1579c7460be0f094264335008\", \"latency_unittests\": \"6dd56ca6bdc6050279ff40b771a1c3c41fec9a04\", \"libjingle_xmpp_unittests\": \"243efff047128a4ff369e2eb0832726af2af9ec4\", \"liburlpattern_unittests\": \"97604db0abe3e1007541b32d8ec964902ffb766e\", \"media_blink_unittests\": \"bd9107e728d7314d469449b647e73134839800b9\", \"media_unittests\": \"c6a74fb35868a2134e8fa39f15dd7e4a81eacf55\", \"message_center_unittests\": \"d6e6d6d86276d5014c7b00f0814e45ec55641b1b\", \"midi_unittests\": \"c28b7c9854891fc5a464a32cbac8297986cb311d\", \"mojo_core_unittests\": \"e296235525774d5b1f4c6c0ffb10f181aacd0fa3\", \"mojo_unittests\": \"5ad59bb02031bf42dd4755a4f2ff469e3366cb6b\", \"nacl_helper_nonsfi_unittests\": \"c257f8ebf05a07737cd2e870be338ab552e5a5de\", \"nacl_loader_unittests\": \"a648129a3878f93a8ca8651645b3c1c4304f1ca0\", \"native_theme_unittests\": \"8dec3dd22aa8503ed18ed88cb6db7602aaa87294\", \"net_unittests\": \"ac413c4dac73f276899da6989bc82cf2e01890b3\", \"ozone_gl_unittests\": \"0cc109b16361b532564078292ae13cae5167c4e8\", \"ozone_unittests\": \"83a32824a45dfce31d3640a9339f8a96498600c1\", \"ozone_x11_unittests\": \"f85fd5d7956acf3ff2cfc996f8c0e83b66a86012\", \"pdf_unittests\": \"a3ba11ccacf4429f5b3ebcce762a8ce93058d766\", \"perfetto_unittests\": \"010a896978dd858ae156cf058757cf7d67707941\", \"ppapi_unittests\": \"4f7b23644875650fb83ebc6efc2b7817ab277e47\", \"printing_unittests\": \"d2a6192a13a5af4a2d2ef01e30109202eeb84182\", \"remoting_unittests\": \"b653b5ba06315af28701940cec54e20f2f4015a5\", \"sandbox_linux_unittests\": \"eb5bc03a248c51dd06168678bc2831a896ad360b\", \"service_manager_unittests\": \"e6d4a6468bc340e8c356ed68dde656508673764f\", \"services_unittests\": \"4f8c19058603b68dc1b959e35ff484b9a4183cea\", \"shell_dialogs_unittests\": \"2433a52e23d57bc1311deaf94d035d98a77ca306\", \"skia_unittests\": \"5953caba66bd8cc4823b1bb3ab72058dd5f7ec8e\", \"snapshot_unittests\": \"b778918c637a3a49e1f02dd23c18d9f2133e3180\", \"sql_unittests\": \"f3a7545724215b930a432bc93cca5072b0724a3d\", \"storage_unittests\": \"4793f3fad32f70275a8a2982317cf586baa1d260\", \"sync_integration_tests\": \"e1a097b944899258062a62b993bd1b359d0fdb59\", \"traffic_annotation_auditor_unittests\": \"8889fe060b476a7da07d87b738ae74316eaef8e2\", \"ui_base_unittests\": \"2a666494de2541abd7fa94b6a122c80d0dd34db8\", \"ui_chromeos_unittests\": \"477ab4f36fe071381bea68b0f91b6d6c9cad00ed\", \"ui_touch_selection_unittests\": \"68467fc38632a62bb73c0b55955589caf2bb24b7\", \"unit_tests\": \"c61a21727fff0ad5c8ae8a6006a7766fccd26b75\", \"url_unittests\": \"a87a2d3ac1e8eb96b752c740e4f1a7cc3f7a65bd\", \"usage_time_limit_unittests\": \"a3e03f03caab4a3b0fe69dd6667e321d358e7736\", \"views_unittests\": \"19345c4ee9a0836b9d4410db03a43b8b2fba847c\", \"viz_unittests\": \"1376654f23719fdfb94d9ceb67ad82cde86bfc5d\", \"wm_unittests\": \"d683f526e61f3592428e3fdf1393526400aa7598\", \"wtf_unittests\": \"f287d83082fef7652487b03c3c2d4f2b3e78ac6b\", \"zlib_unittests\": \"704441e5dc9510be79e61dc95bd378a5e088cd01\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_9b8e7cf0a756f5448fe63e5ba03689dec6fdccd23b3dfddd2910706476b68383_v2\", \"builder_d1ade7eeaf5d4bfec46cdcc4260ff7266c5ca5ac9f935f1643683e9e2b66e303_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-central1-b-8-21-5opr\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5635-1756fdb\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605698026717234",
"status": "COMPLETED",
"status_changed_ts": "1605704111204314",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21367",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2e87369b839558e498fb3a33593b72598c2c5433",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e87369b839558e498fb3a33593b72598c2c5433",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028727368136473424",
"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/8863297305994134256/+/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:4ff3e0fcd0c8c710",
"user_agent:luci-scheduler"
],
"updated_ts": "1605704111210390",
"url": "https://ci.chromium.org/b/8863297305994134256",
"utcnow_ts": "1605704111698652"
}
}
[12:55:11.711] Invocation finished in 1h41m30.329377899s with status SUCCEEDED