[00:56:52.067] New invocation is queued and will start shortly
[00:56:53.197] Starting the invocation (attempt 1)
[00:56:53.229] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:56:53.229] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:56:53.229] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019344090726293312",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"82d2a58e5ec2248db2bba2889be641de04440845\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019344090726293312",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/82d2a58e5ec2248db2bba2889be641de04440845",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82d2a58e5ec2248db2bba2889be641de04440845",
"gitiles_ref:refs/heads/master"
]
}
[00:56:55.052] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614646613539790",
"id": "8853914028520377440",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82d2a58e5ec2248db2bba2889be641de04440845\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614646614749750",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22824",
"builder:linux-chromeos-dbg",
"buildset:commit/git/82d2a58e5ec2248db2bba2889be641de04440845",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82d2a58e5ec2248db2bba2889be641de04440845",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019344090726293312",
"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/8853914028520377440/+/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": "1614646614749901",
"url": "https://ci.chromium.org/b/8853914028520377440",
"utcnow_ts": "1614646615019748"
}
}
[00:56:55.052] Task URL: https://ci.chromium.org/b/8853914028520377440
[00:56:55.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:2:0) after 1m0s
[00:57:55.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:2:0)
[00:57:55.072] Timer tick, asking Buildbucket for the build status
[00:57:55.161] Build 8853914028520377440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:55.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:3:0) after 1m0s
[00:58:55.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:3:0)
[00:58:55.180] Timer tick, asking Buildbucket for the build status
[00:58:55.259] Build 8853914028520377440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:55.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:4:0) after 1m0s
[00:59:35.414] Received PubSub notification, asking Buildbucket for the build status
[00:59:35.510] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:55.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:4:0)
[00:59:55.276] Timer tick, asking Buildbucket for the build status
[00:59:55.365] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:55.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:6:0) after 1m0s
[01:00:55.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:6:0)
[01:00:55.383] Timer tick, asking Buildbucket for the build status
[01:00:56.538] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:56.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:7:0) after 1m0s
[01:01:56.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:7:0)
[01:01:56.558] Timer tick, asking Buildbucket for the build status
[01:01:56.635] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:56.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:8:0) after 1m0s
[01:02:56.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:8:0)
[01:02:56.644] Timer tick, asking Buildbucket for the build status
[01:02:56.773] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:56.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:9:0) after 1m0s
[01:03:56.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:9:0)
[01:03:56.789] Timer tick, asking Buildbucket for the build status
[01:03:57.124] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:57.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:10:0) after 1m0s
[01:04:57.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:10:0)
[01:04:57.133] Timer tick, asking Buildbucket for the build status
[01:04:57.809] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:57.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:11:0) after 1m0s
[01:05:57.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:11:0)
[01:05:57.872] Timer tick, asking Buildbucket for the build status
[01:05:58.001] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:58.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:12:0) after 1m0s
[01:06:58.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:12:0)
[01:06:58.015] Timer tick, asking Buildbucket for the build status
[01:06:58.170] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:58.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:13:0) after 1m0s
[01:07:58.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:13:0)
[01:07:58.213] Timer tick, asking Buildbucket for the build status
[01:07:58.300] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:58.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:14:0) after 1m0s
[01:08:58.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:14:0)
[01:08:58.318] Timer tick, asking Buildbucket for the build status
[01:08:58.516] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:58.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:15:0) after 1m0s
[01:09:58.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:15:0)
[01:09:58.597] Timer tick, asking Buildbucket for the build status
[01:09:58.736] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:58.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:16:0) after 1m0s
[01:10:58.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:16:0)
[01:10:58.830] Timer tick, asking Buildbucket for the build status
[01:10:58.950] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:58.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:17:0) after 1m0s
[01:11:59.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:17:0)
[01:11:59.250] Timer tick, asking Buildbucket for the build status
[01:11:59.315] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:59.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:18:0) after 1m0s
[01:12:59.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:18:0)
[01:12:59.500] Timer tick, asking Buildbucket for the build status
[01:12:59.588] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:59.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:19:0) after 1m0s
[01:13:59.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:19:0)
[01:13:59.578] Timer tick, asking Buildbucket for the build status
[01:13:59.670] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:59.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:20:0) after 1m0s
[01:14:59.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:20:0)
[01:14:59.744] Timer tick, asking Buildbucket for the build status
[01:14:59.895] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:59.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:21:0) after 1m0s
[01:16:00.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:21:0)
[01:16:00.096] Timer tick, asking Buildbucket for the build status
[01:16:00.658] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:00.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:22:0) after 1m0s
[01:17:00.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:22:0)
[01:17:00.758] Timer tick, asking Buildbucket for the build status
[01:17:00.841] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:00.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:23:0) after 1m0s
[01:18:01.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:23:0)
[01:18:01.140] Timer tick, asking Buildbucket for the build status
[01:18:01.210] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:01.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:24:0) after 1m0s
[01:19:01.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:24:0)
[01:19:01.409] Timer tick, asking Buildbucket for the build status
[01:19:01.482] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:01.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:25:0) after 1m0s
[01:20:01.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:25:0)
[01:20:01.921] Timer tick, asking Buildbucket for the build status
[01:20:02.039] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:02.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:26:0) after 1m0s
[01:21:02.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:26:0)
[01:21:02.222] Timer tick, asking Buildbucket for the build status
[01:21:02.286] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:02.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:27:0) after 1m0s
[01:22:02.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:27:0)
[01:22:02.350] Timer tick, asking Buildbucket for the build status
[01:22:02.435] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:02.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:28:0) after 1m0s
[01:23:02.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:28:0)
[01:23:02.488] Timer tick, asking Buildbucket for the build status
[01:23:02.572] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:02.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:29:0) after 1m0s
[01:24:02.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:29:0)
[01:24:02.788] Timer tick, asking Buildbucket for the build status
[01:24:03.065] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:03.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:30:0) after 1m0s
[01:25:03.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:30:0)
[01:25:03.176] Timer tick, asking Buildbucket for the build status
[01:25:03.463] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:03.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:31:0) after 1m0s
[01:26:03.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:31:0)
[01:26:03.466] Timer tick, asking Buildbucket for the build status
[01:26:03.754] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:03.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:32:0) after 1m0s
[01:27:03.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:32:0)
[01:27:03.776] Timer tick, asking Buildbucket for the build status
[01:27:04.015] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:04.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:33:0) after 1m0s
[01:28:04.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:33:0)
[01:28:04.068] Timer tick, asking Buildbucket for the build status
[01:28:04.409] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:04.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:34:0) after 1m0s
[01:29:04.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:34:0)
[01:29:04.487] Timer tick, asking Buildbucket for the build status
[01:29:05.043] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:05.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:35:0) after 1m0s
[01:30:05.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:35:0)
[01:30:05.096] Timer tick, asking Buildbucket for the build status
[01:30:05.223] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:05.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:36:0) after 1m0s
[01:31:05.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:36:0)
[01:31:05.376] Timer tick, asking Buildbucket for the build status
[01:31:05.495] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:05.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:37:0) after 1m0s
[01:32:05.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:37:0)
[01:32:05.605] Timer tick, asking Buildbucket for the build status
[01:32:05.753] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:05.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:38:0) after 1m0s
[01:33:05.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:38:0)
[01:33:05.849] Timer tick, asking Buildbucket for the build status
[01:33:05.913] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:05.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:39:0) after 1m0s
[01:34:06.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:39:0)
[01:34:06.290] Timer tick, asking Buildbucket for the build status
[01:34:06.770] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:06.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:40:0) after 1m0s
[01:35:06.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:40:0)
[01:35:06.808] Timer tick, asking Buildbucket for the build status
[01:35:06.892] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:06.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:41:0) after 1m0s
[01:36:06.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:41:0)
[01:36:06.978] Timer tick, asking Buildbucket for the build status
[01:36:07.268] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:07.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:42:0) after 1m0s
[01:37:07.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:42:0)
[01:37:07.362] Timer tick, asking Buildbucket for the build status
[01:37:07.501] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:07.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:43:0) after 1m0s
[01:38:07.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:43:0)
[01:38:07.578] Timer tick, asking Buildbucket for the build status
[01:38:07.663] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:07.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:44:0) after 1m0s
[01:39:07.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:44:0)
[01:39:07.729] Timer tick, asking Buildbucket for the build status
[01:39:07.838] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:07.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:45:0) after 1m0s
[01:40:08.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:45:0)
[01:40:08.114] Timer tick, asking Buildbucket for the build status
[01:40:08.233] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:08.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:46:0) after 1m0s
[01:41:08.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:46:0)
[01:41:08.464] Timer tick, asking Buildbucket for the build status
[01:41:08.558] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:08.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:47:0) after 1m0s
[01:42:08.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:47:0)
[01:42:08.671] Timer tick, asking Buildbucket for the build status
[01:42:10.178] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:10.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:48:0) after 1m0s
[01:43:10.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:48:0)
[01:43:10.197] Timer tick, asking Buildbucket for the build status
[01:43:10.286] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:10.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:49:0) after 1m0s
[01:44:10.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:49:0)
[01:44:10.308] Timer tick, asking Buildbucket for the build status
[01:44:10.466] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:10.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:50:0) after 1m0s
[01:45:10.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:50:0)
[01:45:10.523] Timer tick, asking Buildbucket for the build status
[01:45:10.612] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:10.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:51:0) after 1m0s
[01:46:10.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:51:0)
[01:46:10.774] Timer tick, asking Buildbucket for the build status
[01:46:11.106] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:11.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:52:0) after 1m0s
[01:47:11.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:52:0)
[01:47:11.195] Timer tick, asking Buildbucket for the build status
[01:47:12.240] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:12.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:53:0) after 1m0s
[01:48:12.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:53:0)
[01:48:12.597] Timer tick, asking Buildbucket for the build status
[01:48:12.836] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:12.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:54:0) after 1m0s
[01:49:12.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:54:0)
[01:49:12.989] Timer tick, asking Buildbucket for the build status
[01:49:13.137] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:13.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:55:0) after 1m0s
[01:50:13.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:55:0)
[01:50:13.251] Timer tick, asking Buildbucket for the build status
[01:50:13.367] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:13.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:56:0) after 1m0s
[01:51:13.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:56:0)
[01:51:13.381] Timer tick, asking Buildbucket for the build status
[01:51:13.518] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:13.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:57:0) after 1m0s
[01:52:13.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:57:0)
[01:52:13.554] Timer tick, asking Buildbucket for the build status
[01:52:13.653] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:13.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:58:0) after 1m0s
[01:53:13.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:58:0)
[01:53:13.675] Timer tick, asking Buildbucket for the build status
[01:53:13.752] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:13.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:59:0) after 1m0s
[01:54:13.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:59:0)
[01:54:13.847] Timer tick, asking Buildbucket for the build status
[01:54:13.957] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:13.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:60:0) after 1m0s
[01:55:14.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:60:0)
[01:55:14.042] Timer tick, asking Buildbucket for the build status
[01:55:14.160] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:14.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:61:0) after 1m0s
[01:56:14.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:61:0)
[01:56:14.372] Timer tick, asking Buildbucket for the build status
[01:56:15.165] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:15.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:62:0) after 1m0s
[01:57:15.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:62:0)
[01:57:15.566] Timer tick, asking Buildbucket for the build status
[01:57:15.666] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:15.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:63:0) after 1m0s
[01:58:15.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:63:0)
[01:58:15.831] Timer tick, asking Buildbucket for the build status
[01:58:16.118] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:16.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:64:0) after 1m0s
[01:59:16.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:64:0)
[01:59:16.471] Timer tick, asking Buildbucket for the build status
[01:59:16.550] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:16.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:65:0) after 1m0s
[02:00:16.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:65:0)
[02:00:16.654] Timer tick, asking Buildbucket for the build status
[02:00:16.775] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:16.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:66:0) after 1m0s
[02:01:16.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:66:0)
[02:01:16.870] Timer tick, asking Buildbucket for the build status
[02:01:17.063] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:17.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:67:0) after 1m0s
[02:02:17.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:67:0)
[02:02:17.067] Timer tick, asking Buildbucket for the build status
[02:02:17.219] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:17.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:68:0) after 1m0s
[02:03:17.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:68:0)
[02:03:17.242] Timer tick, asking Buildbucket for the build status
[02:03:17.348] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:17.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:69:0) after 1m0s
[02:04:17.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:69:0)
[02:04:17.320] Timer tick, asking Buildbucket for the build status
[02:04:17.397] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:17.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:70:0) after 1m0s
[02:05:17.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:70:0)
[02:05:17.567] Timer tick, asking Buildbucket for the build status
[02:05:17.661] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:17.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:71:0) after 1m0s
[02:06:17.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:71:0)
[02:06:17.740] Timer tick, asking Buildbucket for the build status
[02:06:18.500] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:18.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:72:0) after 1m0s
[02:07:18.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:72:0)
[02:07:18.506] Timer tick, asking Buildbucket for the build status
[02:07:18.623] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:18.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:73:0) after 1m0s
[02:08:18.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:73:0)
[02:08:18.692] Timer tick, asking Buildbucket for the build status
[02:08:18.785] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:18.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:74:0) after 1m0s
[02:09:18.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:74:0)
[02:09:18.912] Timer tick, asking Buildbucket for the build status
[02:09:20.161] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:20.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:75:0) after 1m0s
[02:10:20.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:75:0)
[02:10:20.814] Timer tick, asking Buildbucket for the build status
[02:10:20.940] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:20.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:76:0) after 1m0s
[02:11:21.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:76:0)
[02:11:21.075] Timer tick, asking Buildbucket for the build status
[02:11:21.174] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:21.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:77:0) after 1m0s
[02:12:21.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:77:0)
[02:12:21.270] Timer tick, asking Buildbucket for the build status
[02:12:21.371] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:21.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:78:0) after 1m0s
[02:13:21.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:78:0)
[02:13:21.472] Timer tick, asking Buildbucket for the build status
[02:13:21.552] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:21.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:79:0) after 1m0s
[02:14:21.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:79:0)
[02:14:21.615] Timer tick, asking Buildbucket for the build status
[02:14:21.705] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:21.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:80:0) after 1m0s
[02:15:21.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:80:0)
[02:15:21.744] Timer tick, asking Buildbucket for the build status
[02:15:21.847] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:21.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:81:0) after 1m0s
[02:16:21.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:81:0)
[02:16:21.834] Timer tick, asking Buildbucket for the build status
[02:16:21.924] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:21.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:82:0) after 1m0s
[02:17:21.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:82:0)
[02:17:21.957] Timer tick, asking Buildbucket for the build status
[02:17:22.070] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:22.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:83:0) after 1m0s
[02:18:22.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:83:0)
[02:18:22.133] Timer tick, asking Buildbucket for the build status
[02:18:30.374] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:30.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:84:0) after 1m0s
[02:19:30.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:84:0)
[02:19:30.393] Timer tick, asking Buildbucket for the build status
[02:19:30.490] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:30.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:85:0) after 1m0s
[02:20:30.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:85:0)
[02:20:30.465] Timer tick, asking Buildbucket for the build status
[02:20:30.580] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:30.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:86:0) after 1m0s
[02:21:30.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:86:0)
[02:21:30.620] Timer tick, asking Buildbucket for the build status
[02:21:30.785] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:30.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:87:0) after 1m0s
[02:22:30.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:87:0)
[02:22:30.776] Timer tick, asking Buildbucket for the build status
[02:22:30.887] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:30.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:88:0) after 1m0s
[02:23:30.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:88:0)
[02:23:30.961] Timer tick, asking Buildbucket for the build status
[02:23:31.064] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:31.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:89:0) after 1m0s
[02:24:31.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:89:0)
[02:24:31.088] Timer tick, asking Buildbucket for the build status
[02:24:31.187] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:31.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:90:0) after 1m0s
[02:25:31.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:90:0)
[02:25:31.268] Timer tick, asking Buildbucket for the build status
[02:25:32.141] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:32.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:91:0) after 1m0s
[02:26:32.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:91:0)
[02:26:32.533] Timer tick, asking Buildbucket for the build status
[02:26:32.616] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:32.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:92:0) after 1m0s
[02:27:32.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:92:0)
[02:27:32.690] Timer tick, asking Buildbucket for the build status
[02:27:32.925] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:32.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:93:0) after 1m0s
[02:28:33.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:93:0)
[02:28:33.003] Timer tick, asking Buildbucket for the build status
[02:28:33.090] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:33.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:94:0) after 1m0s
[02:29:33.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:94:0)
[02:29:33.175] Timer tick, asking Buildbucket for the build status
[02:29:33.252] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:33.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:95:0) after 1m0s
[02:30:33.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:95:0)
[02:30:33.356] Timer tick, asking Buildbucket for the build status
[02:30:33.450] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:33.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:96:0) after 1m0s
[02:31:33.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:96:0)
[02:31:33.574] Timer tick, asking Buildbucket for the build status
[02:31:33.688] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:33.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:97:0) after 1m0s
[02:32:33.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:97:0)
[02:32:33.778] Timer tick, asking Buildbucket for the build status
[02:32:33.858] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:33.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:98:0) after 1m0s
[02:33:34.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:98:0)
[02:33:34.216] Timer tick, asking Buildbucket for the build status
[02:33:34.415] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:34.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:99:0) after 1m0s
[02:34:34.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:99:0)
[02:34:34.607] Timer tick, asking Buildbucket for the build status
[02:34:34.934] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:34.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:100:0) after 1m0s
[02:35:35.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:100:0)
[02:35:35.013] Timer tick, asking Buildbucket for the build status
[02:35:35.176] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:35.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:101:0) after 1m0s
[02:36:35.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:101:0)
[02:36:35.223] Timer tick, asking Buildbucket for the build status
[02:36:35.471] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:35.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:102:0) after 1m0s
[02:37:35.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:102:0)
[02:37:35.533] Timer tick, asking Buildbucket for the build status
[02:37:35.631] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:35.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:103:0) after 1m0s
[02:38:36.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:103:0)
[02:38:36.917] Timer tick, asking Buildbucket for the build status
[02:38:39.365] Build 8853914028520377440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:39.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019344090726293312:104:0) after 1m0s
[02:38:42.813] Received PubSub notification, asking Buildbucket for the build status
[02:38:43.465] Build 8853914028520377440: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:38:43.465] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614652720732575",
"created_by": "project:chromium",
"created_ts": "1614646613539790",
"id": "8853914028520377440",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82d2a58e5ec2248db2bba2889be641de04440845\"}}",
"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\": \"82d2a58e5ec2248db2bba2889be641de04440845\", \"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-43-612k\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22824, \"got_angle_revision\": \"5b82fa2e842475cd93c6a6119b6e07635054e836\", \"got_dawn_revision\": \"931182485579d2eec3b24c1f2df646870f80da68\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"82d2a58e5ec2248db2bba2889be641de04440845\", \"got_revision_cp\": \"refs/heads/master@{#858807}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"740e24e201f80287f4151c15f61fa684ea53dd3c\", \"got_v8_revision_cp\": \"refs/heads/9.1.9@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"82d2a58e5ec2248db2bba2889be641de04440845\", \"swarm_hashes_refs/heads/master(at){#858807}_without_patch\": {\"absl_hardening_tests\": \"998a3a81d711c3cef0ae92658e7be35de71d8340\", \"accessibility_unittests\": \"5bbe75bd50aa49c39aa072a859c39b111c2246fd\", \"angle_unittests\": \"a9e071c00bd846490115d3771dcc6e3da637e20f\", \"app_list_unittests\": \"3eee56cc9481429aa880789525269bcb6c2ef0a5\", \"app_shell_unittests\": \"e4f1749d548ded72cd60e39692bbb4d1cea2e8cb\", \"ash_unittests\": \"129562c5386eebaaf2c171ff982d3e1c11aef1c4\", \"aura_unittests\": \"f55d4f5100eac30bd7310c849adac387a599318d\", \"base_unittests\": \"92e1082bde936654449e26d96041e4146200edae\", \"base_util_unittests\": \"b66f74c15060897d6c6410898598c7769a94f02e\", \"blink_common_unittests\": \"f801ee27bda81963612cccf917e7ec2cfce04aaa\", \"blink_fuzzer_unittests\": \"7447ea0f43aca4539f329efecdec5f500e2ffed9\", \"blink_heap_unittests\": \"e45e723f84cba1cb5f288cde09204c7822595071\", \"blink_platform_unittests\": \"db0863633a9a6032e7c597151d89ade72477491f\", \"blink_unittests\": \"b5ff24e93f2510af71fb7101b152e96c6e2837f2\", \"boringssl_crypto_tests\": \"a038bb819cab010b936ac8e71a1653994defd43f\", \"boringssl_ssl_tests\": \"582c09d8b1258a65a577dc50e778f5cbba6063be\", \"browser_tests\": \"eb5a5cf326cc3be01dd726253714c7b628175d57\", \"capture_unittests\": \"def7a41d8c818d3751ca30ea5b2f33261501c3d7\", \"cast_unittests\": \"b323facdc8931fb80ecb8138fa283cfc6e27bbca\", \"cc_unittests\": \"69bb3ae43154db3476e8863fb8b120f2ca9d561c\", \"chrome_app_unittests\": \"052e8889f85c45dad044fe31c2ad5aae9f5bf845\", \"chromedriver_unittests\": \"c241c40db5ff2dd87d4dc4bb38f9bc7a8db73e4c\", \"chromeos_components_unittests\": \"464a95e0216f8974a933c0b0fc1fead90fa82f10\", \"chromeos_unittests\": \"0ff69e188bf58d028dec92564cf39020ad60985c\", \"color_unittests\": \"85b414d221ccff127d67fdb35b99c44df9a6ddfe\", \"components_browsertests\": \"3ded1dd9e61108390887ef1cec1797b4e9b19739\", \"components_unittests\": \"bc0c406bec9d4837b0fbd6b86f6d76d377acef0b\", \"compositor_unittests\": \"7dc89e29c5fa1e0aefd6fbe6013e7d81a8fffe6f\", \"content_browsertests\": \"07466541489a73964b41e519fe11b8c1414b8b6c\", \"content_unittests\": \"f76050d98629587f90a109952b607ad024d1aba6\", \"crashpad_tests\": \"329292a662b9eb4a31de0c2977b9912046d39651\", \"crypto_unittests\": \"7a16cba02bf26f3f463ac6f57d820144dccc0afa\", \"dbus_unittests\": \"f415946d0142bc0ab2b9a784ddbec1eaa7a478bb\", \"device_unittests\": \"7fa731b17e70f29585a88a41bc17659246d14a8c\", \"display_unittests\": \"b1adb0075e7ce49ddb51ab461fd7ae0159eeb66a\", \"events_unittests\": \"78640c0a9b842f42a033832121145387c8be83a2\", \"exo_unittests\": \"30f4bd321e66cc985347c87911df70d9ba91e498\", \"extensions_browsertests\": \"99ca143783e384c4a573a1d81e85c634af0883a1\", \"extensions_unittests\": \"90f5f02c0d925c6da4899a9d102b3abd2b08b839\", \"filesystem_service_unittests\": \"ee766730e6d323b8c1eaecea28a20d728e9e2d77\", \"gcm_unit_tests\": \"4666eff5759bd9ed9d82173cbfbeae9440bafb17\", \"gfx_unittests\": \"4c7fd032653c52b13b4a787e796cf8ae2177cffa\", \"gin_unittests\": \"a6af407bbe1346c53efa692b1ae583509fa2421d\", \"gl_unittests_ozone\": \"a18bd1e273002c39a95718e9b3dc165977c294cb\", \"google_apis_unittests\": \"63b40fcea9c165ba05192dbb3167df145ff8f8b2\", \"gpu_unittests\": \"2d4e10774ad3cf97947788c5463ceed9b7c0a7a1\", \"gwp_asan_unittests\": \"bbf8400f86d221737c1c8c3210a9c6e47e12fb98\", \"interactive_ui_tests\": \"9ffb458d630eb1794c3988b408b81c7eef9cebac\", \"ipc_tests\": \"b6d9e21dda35be35211c02cc85b9d4e75cbf6268\", \"jingle_unittests\": \"26ba573d6320b3c2cb1f5e73304c872d4c791081\", \"keyboard_unittests\": \"f46d809aa8bdc35672a691c907653e4332bf39c4\", \"latency_unittests\": \"3855ef6cdd61c68481bd126c386285eeac2942c3\", \"libjingle_xmpp_unittests\": \"7a8db62601a2bf5a9e38a3202b06d00123931746\", \"liburlpattern_unittests\": \"d358227ad6ea8881f7d5cf18960b464c413a780e\", \"media_blink_unittests\": \"3af126df1f96c117f239d120d8611843690926bb\", \"media_unittests\": \"0ce2b4d64b0992e754c8672171365d1d0e7d4137\", \"message_center_unittests\": \"9c750405cffd483f1b0a910be81e977e57f6b6dd\", \"midi_unittests\": \"deb687330b9ef4e8e97d5853a3307e791a5b2ed2\", \"mojo_core_unittests\": \"9e02db7e31c5ec09c52fde1c66d0b28859ef7bda\", \"mojo_unittests\": \"8aed070663fcd9ab2347d3358aede278c572ee61\", \"nacl_helper_nonsfi_unittests\": \"c0f6b324123af79ed9817c2d0c8784d93d4f94cb\", \"nacl_loader_unittests\": \"4f00dea1766e99f3d396a71891cd4688e652c917\", \"native_theme_unittests\": \"8a34af6776ef539317de4c1d56b3e663126c508c\", \"net_unittests\": \"570791147909699c594b01f66ed9a08342b0b892\", \"ozone_gl_unittests\": \"1c1eef0135ecca9ad27910ed9cfc57d06ca41ac4\", \"ozone_unittests\": \"1889c6b6f7eb79b93f063acba84925424ec900b5\", \"ozone_x11_unittests\": \"6ece10536fb579b9d53c4d74e4cf741f983c8b80\", \"pdf_unittests\": \"356ab2f3e3f651314de4ea7890f5819758da920c\", \"perfetto_unittests\": \"35a21b984a6276bcbd73d091f719ce7792423a29\", \"ppapi_unittests\": \"2449e1dd853a1fd75c20d332c606e96f4e0079fd\", \"printing_unittests\": \"2ec91fc7299e54352310ba70b97255f82b1a914e\", \"remoting_unittests\": \"696378db461b605e1a1a53545df8e36b0021a742\", \"sandbox_linux_unittests\": \"fc7498d71e169b26db36f9fc37466936e12a7b40\", \"service_manager_unittests\": \"b2bfff90eb102c869368f2cace933a991048ae13\", \"services_unittests\": \"ca5a3440ee920e550badb70d4852cadc25b599d7\", \"shell_dialogs_unittests\": \"36e9eb922e0a7200acd9dc2bf0ca342d277d4a3f\", \"shell_encryption_unittests\": \"fa334fed58dcd5dc2baa3c81a30508df1c253e4f\", \"skia_unittests\": \"fb9da3455d973750b79eea99e78fdaa9f486224d\", \"snapshot_unittests\": \"d125dc9f90fade61c224127cc23b648473a5c356\", \"sql_unittests\": \"e313a922bf6bc4d8a53d19770d886c28b0c2d083\", \"storage_unittests\": \"7adac9d54ccd8bb086b43360c28271ed9aa09f00\", \"sync_integration_tests\": \"a07ce5fdc096ddb2939a83e85b9b971361d4409e\", \"traffic_annotation_auditor_unittests\": \"c0560d4a225f56e70dc57acbb8669c247bd32748\", \"ui_base_unittests\": \"3a8225b6a13c0feffd14464dddd4f7ef4ad395d9\", \"ui_chromeos_unittests\": \"5503ae85c913910bbce1a42551733be031334b93\", \"ui_touch_selection_unittests\": \"06d7594c07fcb59141a0a979e2de2e8942cbabca\", \"unit_tests\": \"2498c8e24c5cc3e3ecfc7f80ad1485b1366e9d27\", \"url_unittests\": \"c6279c82f520806eba786d3a3c75dd42b0e0389d\", \"usage_time_limit_unittests\": \"8bd14cccb85f4880d6aad624e470d7a961a38bee\", \"views_unittests\": \"295fb0edee3e9fe9108fd314aeae23af59555eb1\", \"viz_unittests\": \"7b7b4090757255bb8fc65e39a28ca3c7783686f3\", \"wayland_client_tests\": \"16ca2bf544ef26b2cda9231b0cd0e4b02b8757aa\", \"wm_unittests\": \"856b2973896b11236e7c1e7a3e6340e0c8409dc0\", \"wtf_unittests\": \"d43420dadcdb6303ab8cef0f6c2dc80863968d32\", \"zlib_unittests\": \"f4b4d34298e9ea767c9079c568dc40cef2193cf3\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_5f931a5519f78feef046af549827aa56dc2e9b17853b60b3d0ae8ebd533780ee_v2\", \"builder_7a9f94695aa83f7478015e01762e75301e67c95c681ec0592232bd343861e191_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-43-612k\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614646774951740",
"status": "COMPLETED",
"status_changed_ts": "1614652721160951",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22824",
"builder:linux-chromeos-dbg",
"buildset:commit/git/82d2a58e5ec2248db2bba2889be641de04440845",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82d2a58e5ec2248db2bba2889be641de04440845",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019344090726293312",
"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/8853914028520377440/+/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:520941cf935cb810",
"user_agent:luci-scheduler"
],
"updated_ts": "1614652721173322",
"url": "https://ci.chromium.org/b/8853914028520377440",
"utcnow_ts": "1614652723451038"
}
}
[02:38:43.465] Invocation finished in 1h41m51.414115772s with status SUCCEEDED