[19:05:48.650] New invocation is queued and will start shortly
[19:05:50.001] Starting the invocation (attempt 1)
[19:05:50.043] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:05:50.043] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:05:50.043] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9092296735276495600",
"parameters_json": "{\"builder_name\":\"linux-code-coverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ddb92bdd44ce9dcbad4769ab4b90ec53940518a3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-code-coverage",
"scheduler_invocation_id:9092296735276495600",
"scheduler_job_id:chromium/linux-code-coverage",
"user_agent:luci-scheduler",
"buildset:commit/git/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"gitiles_ref:refs/heads/master"
]
}
[19:05:51.330] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1545073550132381",
"id": "8926866673054564272",
"lease_expiration_ts": "1545253550960464",
"lease_key": "1640985077",
"parameters_json": "{\"builder_name\": \"linux-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ddb92bdd44ce9dcbad4769ab4b90ec53940518a3\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1545073551138277",
"tags": [
"build_address:luci.chromium.ci/linux-code-coverage/1496",
"builder:linux-code-coverage",
"buildset:commit/git/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9092296735276495600",
"scheduler_job_id:chromium/linux-code-coverage",
"swarming_dimension:builder:linux-code-coverage",
"swarming_dimension:caches:builder_f0e85433ca60e21ba10033b857841d88af052436c6cb8411b561ff60a2c00a4a_v2",
"swarming_dimension:cores:32",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/linux-code-coverage/1496",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8926866673054564272",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
"swarming_tag:builder:linux-code-coverage",
"swarming_tag:buildset:commit/git/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"swarming_tag:caches:builder_f0e85433ca60e21ba10033b857841d88af052436c6cb8411b561ff60a2c00a4a_v2",
"swarming_tag:cores:32",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8926866673054564272/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9092296735276495600",
"swarming_tag:scheduler_job_id:chromium/linux-code-coverage",
"swarming_tag:service_account:chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:f86ec1ccbac5d2a2a6efc116e37c5e0761c3764b",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41d660ed6ff12e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1545073551138397",
"url": "https://ci.chromium.org/b/8926866673054564272",
"utcnow_ts": "1545073551318803"
}
}
[19:05:51.330] Task URL: https://ci.chromium.org/b/8926866673054564272
[19:05:51.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:2:0) after 1m0s
[19:06:51.352] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:2:0)
[19:06:51.352] Timer tick, asking Buildbucket for the build status
[19:06:51.403] Build 8926866673054564272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:51.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:3:0) after 1m0s
[19:07:15.496] Received PubSub notification, asking Buildbucket for the build status
[19:07:15.545] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:51.431] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:3:0)
[19:07:51.431] Timer tick, asking Buildbucket for the build status
[19:07:51.487] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:51.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:5:0) after 1m0s
[19:08:51.528] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:5:0)
[19:08:51.528] Timer tick, asking Buildbucket for the build status
[19:08:51.598] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:51.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:6:0) after 1m0s
[19:09:51.637] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:6:0)
[19:09:51.637] Timer tick, asking Buildbucket for the build status
[19:09:51.921] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:51.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:7:0) after 1m0s
[19:10:52.085] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:7:0)
[19:10:52.085] Timer tick, asking Buildbucket for the build status
[19:10:52.159] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:52.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:8:0) after 1m0s
[19:11:52.406] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:8:0)
[19:11:52.406] Timer tick, asking Buildbucket for the build status
[19:11:52.537] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:52.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:9:0) after 1m0s
[19:12:52.569] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:9:0)
[19:12:52.569] Timer tick, asking Buildbucket for the build status
[19:12:52.692] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:52.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:10:0) after 1m0s
[19:13:52.845] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:10:0)
[19:13:52.845] Timer tick, asking Buildbucket for the build status
[19:13:53.037] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:53.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:11:0) after 1m0s
[19:14:53.063] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:11:0)
[19:14:53.063] Timer tick, asking Buildbucket for the build status
[19:14:53.115] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:53.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:12:0) after 1m0s
[19:15:53.184] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:12:0)
[19:15:53.184] Timer tick, asking Buildbucket for the build status
[19:15:53.267] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:53.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:13:0) after 1m0s
[19:16:53.390] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:13:0)
[19:16:53.390] Timer tick, asking Buildbucket for the build status
[19:16:53.477] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:53.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:14:0) after 1m0s
[19:17:53.498] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:14:0)
[19:17:53.498] Timer tick, asking Buildbucket for the build status
[19:17:53.578] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:53.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:15:0) after 1m0s
[19:18:53.608] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:15:0)
[19:18:53.608] Timer tick, asking Buildbucket for the build status
[19:18:53.671] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:53.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:16:0) after 1m0s
[19:19:53.699] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:16:0)
[19:19:53.699] Timer tick, asking Buildbucket for the build status
[19:19:53.761] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:53.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:17:0) after 1m0s
[19:20:53.798] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:17:0)
[19:20:53.798] Timer tick, asking Buildbucket for the build status
[19:20:53.844] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:53.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:18:0) after 1m0s
[19:21:53.893] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:18:0)
[19:21:53.893] Timer tick, asking Buildbucket for the build status
[19:21:54.092] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:54.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:19:0) after 1m0s
[19:22:54.120] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:19:0)
[19:22:54.120] Timer tick, asking Buildbucket for the build status
[19:22:54.179] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:54.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:20:0) after 1m0s
[19:23:54.202] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:20:0)
[19:23:54.202] Timer tick, asking Buildbucket for the build status
[19:23:54.244] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:54.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:21:0) after 1m0s
[19:24:54.272] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:21:0)
[19:24:54.272] Timer tick, asking Buildbucket for the build status
[19:24:54.317] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:54.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:22:0) after 1m0s
[19:25:54.437] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:22:0)
[19:25:54.437] Timer tick, asking Buildbucket for the build status
[19:25:54.658] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:54.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:23:0) after 1m0s
[19:26:54.682] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:23:0)
[19:26:54.682] Timer tick, asking Buildbucket for the build status
[19:26:54.774] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:54.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:24:0) after 1m0s
[19:27:54.836] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:24:0)
[19:27:54.836] Timer tick, asking Buildbucket for the build status
[19:27:54.896] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:54.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:25:0) after 1m0s
[19:28:54.923] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:25:0)
[19:28:54.923] Timer tick, asking Buildbucket for the build status
[19:28:54.963] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:54.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:26:0) after 1m0s
[19:29:54.989] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:26:0)
[19:29:54.989] Timer tick, asking Buildbucket for the build status
[19:29:55.069] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:55.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:27:0) after 1m0s
[19:30:55.094] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:27:0)
[19:30:55.094] Timer tick, asking Buildbucket for the build status
[19:30:55.142] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:55.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:28:0) after 1m0s
[19:31:55.166] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:28:0)
[19:31:55.166] Timer tick, asking Buildbucket for the build status
[19:31:55.248] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:55.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:29:0) after 1m0s
[19:32:55.289] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:29:0)
[19:32:55.289] Timer tick, asking Buildbucket for the build status
[19:32:55.341] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:55.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:30:0) after 1m0s
[19:33:55.367] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:30:0)
[19:33:55.367] Timer tick, asking Buildbucket for the build status
[19:33:55.485] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:55.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:31:0) after 1m0s
[19:34:55.509] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:31:0)
[19:34:55.509] Timer tick, asking Buildbucket for the build status
[19:34:55.544] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:55.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:32:0) after 1m0s
[19:35:55.569] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:32:0)
[19:35:55.569] Timer tick, asking Buildbucket for the build status
[19:35:55.598] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:55.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:33:0) after 1m0s
[19:36:55.624] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:33:0)
[19:36:55.624] Timer tick, asking Buildbucket for the build status
[19:36:55.693] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:55.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:34:0) after 1m0s
[19:37:55.716] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:34:0)
[19:37:55.716] Timer tick, asking Buildbucket for the build status
[19:37:55.764] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:55.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:35:0) after 1m0s
[19:38:55.795] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:35:0)
[19:38:55.795] Timer tick, asking Buildbucket for the build status
[19:38:55.892] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:55.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:36:0) after 1m0s
[19:39:55.919] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:36:0)
[19:39:55.919] Timer tick, asking Buildbucket for the build status
[19:39:56.322] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:56.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:37:0) after 1m0s
[19:40:56.350] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:37:0)
[19:40:56.350] Timer tick, asking Buildbucket for the build status
[19:40:56.384] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:56.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:38:0) after 1m0s
[19:41:56.465] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:38:0)
[19:41:56.465] Timer tick, asking Buildbucket for the build status
[19:41:56.517] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:56.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:39:0) after 1m0s
[19:42:56.657] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:39:0)
[19:42:56.657] Timer tick, asking Buildbucket for the build status
[19:42:56.874] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:56.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:40:0) after 1m0s
[19:43:56.897] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:40:0)
[19:43:56.897] Timer tick, asking Buildbucket for the build status
[19:43:56.983] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:56.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:41:0) after 1m0s
[19:44:57.013] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:41:0)
[19:44:57.013] Timer tick, asking Buildbucket for the build status
[19:44:57.059] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:57.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:42:0) after 1m0s
[19:45:57.087] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:42:0)
[19:45:57.087] Timer tick, asking Buildbucket for the build status
[19:45:57.153] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:57.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:43:0) after 1m0s
[19:46:57.181] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:43:0)
[19:46:57.181] Timer tick, asking Buildbucket for the build status
[19:46:57.238] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:57.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:44:0) after 1m0s
[19:47:57.268] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:44:0)
[19:47:57.268] Timer tick, asking Buildbucket for the build status
[19:47:57.320] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:57.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:45:0) after 1m0s
[19:48:57.389] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:45:0)
[19:48:57.389] Timer tick, asking Buildbucket for the build status
[19:48:57.541] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:57.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:46:0) after 1m0s
[19:49:57.571] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:46:0)
[19:49:57.571] Timer tick, asking Buildbucket for the build status
[19:49:57.657] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:57.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:47:0) after 1m0s
[19:50:57.686] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:47:0)
[19:50:57.686] Timer tick, asking Buildbucket for the build status
[19:50:57.755] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:57.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:48:0) after 1m0s
[19:51:57.786] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:48:0)
[19:51:57.786] Timer tick, asking Buildbucket for the build status
[19:51:57.850] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:57.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:49:0) after 1m0s
[19:52:57.893] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:49:0)
[19:52:57.893] Timer tick, asking Buildbucket for the build status
[19:52:58.042] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:58.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:50:0) after 1m0s
[19:53:58.137] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:50:0)
[19:53:58.137] Timer tick, asking Buildbucket for the build status
[19:53:58.382] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:58.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:51:0) after 1m0s
[19:54:58.429] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:51:0)
[19:54:58.429] Timer tick, asking Buildbucket for the build status
[19:54:58.514] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:58.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:52:0) after 1m0s
[19:55:58.538] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:52:0)
[19:55:58.538] Timer tick, asking Buildbucket for the build status
[19:55:58.643] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:58.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:53:0) after 1m0s
[19:56:58.672] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:53:0)
[19:56:58.672] Timer tick, asking Buildbucket for the build status
[19:56:58.854] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:58.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:54:0) after 1m0s
[19:57:58.898] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:54:0)
[19:57:58.898] Timer tick, asking Buildbucket for the build status
[19:57:58.982] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:58.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:55:0) after 1m0s
[19:58:59.011] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:55:0)
[19:58:59.011] Timer tick, asking Buildbucket for the build status
[19:58:59.074] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:59.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:56:0) after 1m0s
[19:59:59.172] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:56:0)
[19:59:59.172] Timer tick, asking Buildbucket for the build status
[19:59:59.260] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:59.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:57:0) after 1m0s
[20:00:59.295] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:57:0)
[20:00:59.295] Timer tick, asking Buildbucket for the build status
[20:00:59.383] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:59.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:58:0) after 1m0s
[20:01:59.415] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:58:0)
[20:01:59.415] Timer tick, asking Buildbucket for the build status
[20:01:59.504] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:59.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:59:0) after 1m0s
[20:02:59.531] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:59:0)
[20:02:59.531] Timer tick, asking Buildbucket for the build status
[20:02:59.666] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:59.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:60:0) after 1m0s
[20:03:59.694] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:60:0)
[20:03:59.694] Timer tick, asking Buildbucket for the build status
[20:03:59.805] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:59.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:61:0) after 1m0s
[20:04:59.835] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:61:0)
[20:04:59.835] Timer tick, asking Buildbucket for the build status
[20:05:00.095] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:00.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:62:0) after 1m0s
[20:06:00.120] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:62:0)
[20:06:00.120] Timer tick, asking Buildbucket for the build status
[20:06:00.201] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:00.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:63:0) after 1m0s
[20:07:00.234] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:63:0)
[20:07:00.234] Timer tick, asking Buildbucket for the build status
[20:07:00.305] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:00.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:64:0) after 1m0s
[20:08:00.329] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:64:0)
[20:08:00.329] Timer tick, asking Buildbucket for the build status
[20:08:00.407] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:00.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:65:0) after 1m0s
[20:09:00.446] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:65:0)
[20:09:00.446] Timer tick, asking Buildbucket for the build status
[20:09:00.513] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:00.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:66:0) after 1m0s
[20:10:00.544] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:66:0)
[20:10:00.544] Timer tick, asking Buildbucket for the build status
[20:10:00.609] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:00.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:67:0) after 1m0s
[20:11:00.639] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:67:0)
[20:11:00.639] Timer tick, asking Buildbucket for the build status
[20:11:00.863] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:00.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:68:0) after 1m0s
[20:12:00.898] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:68:0)
[20:12:00.898] Timer tick, asking Buildbucket for the build status
[20:12:01.114] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:01.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:69:0) after 1m0s
[20:13:01.163] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:69:0)
[20:13:01.163] Timer tick, asking Buildbucket for the build status
[20:13:01.479] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:01.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:70:0) after 1m0s
[20:14:01.498] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:70:0)
[20:14:01.498] Timer tick, asking Buildbucket for the build status
[20:14:01.595] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:01.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:71:0) after 1m0s
[20:15:01.630] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:71:0)
[20:15:01.630] Timer tick, asking Buildbucket for the build status
[20:15:03.820] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:03.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:72:0) after 1m0s
[20:16:03.852] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:72:0)
[20:16:03.852] Timer tick, asking Buildbucket for the build status
[20:16:03.987] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:03.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:73:0) after 1m0s
[20:17:04.043] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:73:0)
[20:17:04.043] Timer tick, asking Buildbucket for the build status
[20:17:04.119] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:04.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:74:0) after 1m0s
[20:18:04.148] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:74:0)
[20:18:04.148] Timer tick, asking Buildbucket for the build status
[20:18:04.267] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:04.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:75:0) after 1m0s
[20:19:04.312] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:75:0)
[20:19:04.312] Timer tick, asking Buildbucket for the build status
[20:19:04.387] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:04.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:76:0) after 1m0s
[20:20:04.418] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:76:0)
[20:20:04.418] Timer tick, asking Buildbucket for the build status
[20:20:04.591] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:04.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:77:0) after 1m0s
[20:21:04.619] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:77:0)
[20:21:04.619] Timer tick, asking Buildbucket for the build status
[20:21:04.725] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:04.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:78:0) after 1m0s
[20:22:04.758] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:78:0)
[20:22:04.758] Timer tick, asking Buildbucket for the build status
[20:22:04.842] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:04.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:79:0) after 1m0s
[20:23:04.877] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:79:0)
[20:23:04.877] Timer tick, asking Buildbucket for the build status
[20:23:04.971] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:04.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:80:0) after 1m0s
[20:24:05.097] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:80:0)
[20:24:05.097] Timer tick, asking Buildbucket for the build status
[20:24:05.175] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:05.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:81:0) after 1m0s
[20:25:05.203] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:81:0)
[20:25:05.203] Timer tick, asking Buildbucket for the build status
[20:25:05.335] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:05.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:82:0) after 1m0s
[20:26:05.454] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:82:0)
[20:26:05.454] Timer tick, asking Buildbucket for the build status
[20:26:05.556] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:05.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:83:0) after 1m0s
[20:27:05.580] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:83:0)
[20:27:05.580] Timer tick, asking Buildbucket for the build status
[20:27:05.667] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:05.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:84:0) after 1m0s
[20:28:05.692] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:84:0)
[20:28:05.692] Timer tick, asking Buildbucket for the build status
[20:28:05.762] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:05.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:85:0) after 1m0s
[20:29:05.787] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:85:0)
[20:29:05.787] Timer tick, asking Buildbucket for the build status
[20:29:05.991] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:05.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:86:0) after 1m0s
[20:30:06.017] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:86:0)
[20:30:06.017] Timer tick, asking Buildbucket for the build status
[20:30:06.185] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:06.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:87:0) after 1m0s
[20:31:06.227] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:87:0)
[20:31:06.227] Timer tick, asking Buildbucket for the build status
[20:31:06.314] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:06.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:88:0) after 1m0s
[20:32:06.340] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:88:0)
[20:32:06.340] Timer tick, asking Buildbucket for the build status
[20:32:06.618] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:06.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:89:0) after 1m0s
[20:33:06.651] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:89:0)
[20:33:06.651] Timer tick, asking Buildbucket for the build status
[20:33:06.752] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:06.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:90:0) after 1m0s
[20:34:06.775] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:90:0)
[20:34:06.775] Timer tick, asking Buildbucket for the build status
[20:34:06.912] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:06.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:91:0) after 1m0s
[20:35:07.009] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:91:0)
[20:35:07.009] Timer tick, asking Buildbucket for the build status
[20:35:07.075] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:07.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:92:0) after 1m0s
[20:36:07.114] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:92:0)
[20:36:07.114] Timer tick, asking Buildbucket for the build status
[20:36:07.195] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:07.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:93:0) after 1m0s
[20:37:07.225] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:93:0)
[20:37:07.225] Timer tick, asking Buildbucket for the build status
[20:37:07.464] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:07.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:94:0) after 1m0s
[20:38:07.493] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:94:0)
[20:38:07.493] Timer tick, asking Buildbucket for the build status
[20:38:07.624] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:07.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:95:0) after 1m0s
[20:39:07.651] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:95:0)
[20:39:07.651] Timer tick, asking Buildbucket for the build status
[20:39:07.719] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:07.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:96:0) after 1m0s
[20:40:07.745] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:96:0)
[20:40:07.745] Timer tick, asking Buildbucket for the build status
[20:40:08.012] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:08.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:97:0) after 1m0s
[20:41:08.068] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:97:0)
[20:41:08.068] Timer tick, asking Buildbucket for the build status
[20:41:08.197] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:08.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:98:0) after 1m0s
[20:42:08.242] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:98:0)
[20:42:08.242] Timer tick, asking Buildbucket for the build status
[20:42:08.385] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:08.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:99:0) after 1m0s
[20:43:08.414] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:99:0)
[20:43:08.414] Timer tick, asking Buildbucket for the build status
[20:43:08.546] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:08.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:100:0) after 1m0s
[20:44:08.568] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:100:0)
[20:44:08.568] Timer tick, asking Buildbucket for the build status
[20:44:08.667] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:08.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:101:0) after 1m0s
[20:45:08.695] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:101:0)
[20:45:08.695] Timer tick, asking Buildbucket for the build status
[20:45:08.777] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:08.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:102:0) after 1m0s
[20:46:08.836] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:102:0)
[20:46:08.836] Timer tick, asking Buildbucket for the build status
[20:46:08.894] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:08.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:103:0) after 1m0s
[20:47:08.942] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:103:0)
[20:47:08.942] Timer tick, asking Buildbucket for the build status
[20:47:09.027] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:09.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:104:0) after 1m0s
[20:48:09.056] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:104:0)
[20:48:09.056] Timer tick, asking Buildbucket for the build status
[20:48:09.226] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:09.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:105:0) after 1m0s
[20:49:09.253] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:105:0)
[20:49:09.253] Timer tick, asking Buildbucket for the build status
[20:49:09.329] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:09.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:106:0) after 1m0s
[20:50:09.361] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:106:0)
[20:50:09.361] Timer tick, asking Buildbucket for the build status
[20:50:09.496] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:09.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:107:0) after 1m0s
[20:51:09.526] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:107:0)
[20:51:09.526] Timer tick, asking Buildbucket for the build status
[20:51:09.601] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:09.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:108:0) after 1m0s
[20:52:09.729] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:108:0)
[20:52:09.729] Timer tick, asking Buildbucket for the build status
[20:52:09.806] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:09.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:109:0) after 1m0s
[20:53:09.833] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:109:0)
[20:53:09.833] Timer tick, asking Buildbucket for the build status
[20:53:09.910] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:09.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:110:0) after 1m0s
[20:54:09.936] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:110:0)
[20:54:09.936] Timer tick, asking Buildbucket for the build status
[20:54:10.005] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:10.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:111:0) after 1m0s
[20:55:10.032] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:111:0)
[20:55:10.032] Timer tick, asking Buildbucket for the build status
[20:55:10.111] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:10.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:112:0) after 1m0s
[20:56:10.145] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:112:0)
[20:56:10.145] Timer tick, asking Buildbucket for the build status
[20:56:10.210] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:10.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:113:0) after 1m0s
[20:57:10.240] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:113:0)
[20:57:10.240] Timer tick, asking Buildbucket for the build status
[20:57:10.305] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:10.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:114:0) after 1m0s
[20:58:10.338] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:114:0)
[20:58:10.338] Timer tick, asking Buildbucket for the build status
[20:58:10.450] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:10.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:115:0) after 1m0s
[20:59:10.491] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:115:0)
[20:59:10.491] Timer tick, asking Buildbucket for the build status
[20:59:10.547] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:10.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:116:0) after 1m0s
[21:00:10.574] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:116:0)
[21:00:10.574] Timer tick, asking Buildbucket for the build status
[21:00:10.693] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:10.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:117:0) after 1m0s
[21:01:10.723] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:117:0)
[21:01:10.723] Timer tick, asking Buildbucket for the build status
[21:01:10.913] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:10.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:118:0) after 1m0s
[21:02:10.965] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:118:0)
[21:02:10.965] Timer tick, asking Buildbucket for the build status
[21:02:11.058] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:11.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:119:0) after 1m0s
[21:03:11.086] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:119:0)
[21:03:11.086] Timer tick, asking Buildbucket for the build status
[21:03:11.533] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:11.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:120:0) after 1m0s
[21:04:11.648] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:120:0)
[21:04:11.648] Timer tick, asking Buildbucket for the build status
[21:04:11.768] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:11.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:121:0) after 1m0s
[21:05:11.799] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:121:0)
[21:05:11.799] Timer tick, asking Buildbucket for the build status
[21:05:11.949] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:11.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:122:0) after 1m0s
[21:06:11.980] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:122:0)
[21:06:11.981] Timer tick, asking Buildbucket for the build status
[21:06:12.054] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:12.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:123:0) after 1m0s
[21:07:12.084] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:123:0)
[21:07:12.084] Timer tick, asking Buildbucket for the build status
[21:07:12.174] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:12.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:124:0) after 1m0s
[21:08:12.203] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:124:0)
[21:08:12.203] Timer tick, asking Buildbucket for the build status
[21:08:12.385] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:12.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:125:0) after 1m0s
[21:09:12.428] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:125:0)
[21:09:12.428] Timer tick, asking Buildbucket for the build status
[21:09:12.479] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:12.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:126:0) after 1m0s
[21:10:12.568] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:126:0)
[21:10:12.568] Timer tick, asking Buildbucket for the build status
[21:10:12.652] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:12.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:127:0) after 1m0s
[21:11:12.678] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:127:0)
[21:11:12.678] Timer tick, asking Buildbucket for the build status
[21:11:12.750] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:12.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:128:0) after 1m0s
[21:12:12.779] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:128:0)
[21:12:12.779] Timer tick, asking Buildbucket for the build status
[21:12:12.863] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:12.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:129:0) after 1m0s
[21:13:12.892] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:129:0)
[21:13:12.892] Timer tick, asking Buildbucket for the build status
[21:13:12.946] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:12.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:130:0) after 1m0s
[21:14:12.979] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:130:0)
[21:14:12.979] Timer tick, asking Buildbucket for the build status
[21:14:13.060] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:13.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:131:0) after 1m0s
[21:15:13.092] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:131:0)
[21:15:13.092] Timer tick, asking Buildbucket for the build status
[21:15:13.173] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:13.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:132:0) after 1m0s
[21:16:13.204] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:132:0)
[21:16:13.204] Timer tick, asking Buildbucket for the build status
[21:16:13.273] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:13.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:133:0) after 1m0s
[21:17:13.304] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:133:0)
[21:17:13.304] Timer tick, asking Buildbucket for the build status
[21:17:13.365] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:13.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:134:0) after 1m0s
[21:18:13.399] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:134:0)
[21:18:13.399] Timer tick, asking Buildbucket for the build status
[21:18:13.479] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:13.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:135:0) after 1m0s
[21:19:13.506] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:135:0)
[21:19:13.506] Timer tick, asking Buildbucket for the build status
[21:19:13.548] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:13.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:136:0) after 1m0s
[21:20:13.578] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:136:0)
[21:20:13.578] Timer tick, asking Buildbucket for the build status
[21:20:13.652] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:13.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:137:0) after 1m0s
[21:21:13.680] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:137:0)
[21:21:13.680] Timer tick, asking Buildbucket for the build status
[21:21:13.774] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:13.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:138:0) after 1m0s
[21:22:13.804] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:138:0)
[21:22:13.804] Timer tick, asking Buildbucket for the build status
[21:22:13.901] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:13.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:139:0) after 1m0s
[21:23:13.934] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:139:0)
[21:23:13.934] Timer tick, asking Buildbucket for the build status
[21:23:14.119] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:14.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:140:0) after 1m0s
[21:24:14.160] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:140:0)
[21:24:14.160] Timer tick, asking Buildbucket for the build status
[21:24:14.262] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:14.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:141:0) after 1m0s
[21:25:14.296] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:141:0)
[21:25:14.296] Timer tick, asking Buildbucket for the build status
[21:25:14.347] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:14.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:142:0) after 1m0s
[21:26:14.387] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:142:0)
[21:26:14.387] Timer tick, asking Buildbucket for the build status
[21:26:14.554] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:14.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:143:0) after 1m0s
[21:27:14.584] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:143:0)
[21:27:14.584] Timer tick, asking Buildbucket for the build status
[21:27:14.686] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:14.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:144:0) after 1m0s
[21:28:14.714] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:144:0)
[21:28:14.714] Timer tick, asking Buildbucket for the build status
[21:28:14.848] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:14.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:145:0) after 1m0s
[21:29:14.877] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:145:0)
[21:29:14.877] Timer tick, asking Buildbucket for the build status
[21:29:15.055] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:15.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:146:0) after 1m0s
[21:30:15.158] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:146:0)
[21:30:15.158] Timer tick, asking Buildbucket for the build status
[21:30:15.290] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:15.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:147:0) after 1m0s
[21:31:15.318] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:147:0)
[21:31:15.318] Timer tick, asking Buildbucket for the build status
[21:31:15.361] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:15.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:148:0) after 1m0s
[21:32:15.458] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:148:0)
[21:32:15.458] Timer tick, asking Buildbucket for the build status
[21:32:15.573] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:15.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:149:0) after 1m0s
[21:33:15.602] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:149:0)
[21:33:15.602] Timer tick, asking Buildbucket for the build status
[21:33:15.666] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:15.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:150:0) after 1m0s
[21:34:15.689] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:150:0)
[21:34:15.689] Timer tick, asking Buildbucket for the build status
[21:34:16.041] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:16.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:151:0) after 1m0s
[21:35:16.072] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:151:0)
[21:35:16.072] Timer tick, asking Buildbucket for the build status
[21:35:16.136] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:16.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:152:0) after 1m0s
[21:36:16.165] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:152:0)
[21:36:16.165] Timer tick, asking Buildbucket for the build status
[21:36:16.213] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:16.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:153:0) after 1m0s
[21:37:16.244] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:153:0)
[21:37:16.244] Timer tick, asking Buildbucket for the build status
[21:37:16.364] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:16.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:154:0) after 1m0s
[21:38:16.462] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:154:0)
[21:38:16.462] Timer tick, asking Buildbucket for the build status
[21:38:16.717] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:16.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:155:0) after 1m0s
[21:39:16.802] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:155:0)
[21:39:16.802] Timer tick, asking Buildbucket for the build status
[21:39:16.870] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:16.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:156:0) after 1m0s
[21:40:16.898] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:156:0)
[21:40:16.898] Timer tick, asking Buildbucket for the build status
[21:40:17.069] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:17.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:157:0) after 1m0s
[21:41:17.102] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:157:0)
[21:41:17.102] Timer tick, asking Buildbucket for the build status
[21:41:17.215] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:17.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:158:0) after 1m0s
[21:42:17.248] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:158:0)
[21:42:17.248] Timer tick, asking Buildbucket for the build status
[21:42:17.376] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:17.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:159:0) after 1m0s
[21:43:17.424] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:159:0)
[21:43:17.424] Timer tick, asking Buildbucket for the build status
[21:43:17.594] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:17.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:160:0) after 1m0s
[21:44:17.624] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:160:0)
[21:44:17.624] Timer tick, asking Buildbucket for the build status
[21:44:17.692] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:17.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:161:0) after 1m0s
[21:45:17.721] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:161:0)
[21:45:17.721] Timer tick, asking Buildbucket for the build status
[21:45:17.770] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:17.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:162:0) after 1m0s
[21:46:17.803] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:162:0)
[21:46:17.803] Timer tick, asking Buildbucket for the build status
[21:46:17.914] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:17.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:163:0) after 1m0s
[21:47:17.949] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:163:0)
[21:47:17.949] Timer tick, asking Buildbucket for the build status
[21:47:18.046] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:18.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:164:0) after 1m0s
[21:48:18.078] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:164:0)
[21:48:18.078] Timer tick, asking Buildbucket for the build status
[21:48:18.162] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:18.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:165:0) after 1m0s
[21:49:18.191] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:165:0)
[21:49:18.191] Timer tick, asking Buildbucket for the build status
[21:49:18.240] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:18.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:166:0) after 1m0s
[21:50:18.272] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:166:0)
[21:50:18.273] Timer tick, asking Buildbucket for the build status
[21:50:18.337] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:18.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:167:0) after 1m0s
[21:51:18.371] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:167:0)
[21:51:18.371] Timer tick, asking Buildbucket for the build status
[21:51:18.482] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:18.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:168:0) after 1m0s
[21:52:18.514] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:168:0)
[21:52:18.514] Timer tick, asking Buildbucket for the build status
[21:52:18.583] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:18.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:169:0) after 1m0s
[21:53:18.608] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:169:0)
[21:53:18.608] Timer tick, asking Buildbucket for the build status
[21:53:18.751] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:18.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:170:0) after 1m0s
[21:54:18.779] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:170:0)
[21:54:18.779] Timer tick, asking Buildbucket for the build status
[21:54:18.827] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:18.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:171:0) after 1m0s
[21:55:18.853] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:171:0)
[21:55:18.853] Timer tick, asking Buildbucket for the build status
[21:55:19.045] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:19.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:172:0) after 1m0s
[21:56:19.087] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:172:0)
[21:56:19.087] Timer tick, asking Buildbucket for the build status
[21:56:19.162] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:19.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:173:0) after 1m0s
[21:57:19.224] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:173:0)
[21:57:19.224] Timer tick, asking Buildbucket for the build status
[21:57:19.424] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:19.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:174:0) after 1m0s
[21:58:19.456] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:174:0)
[21:58:19.456] Timer tick, asking Buildbucket for the build status
[21:58:19.501] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:19.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:175:0) after 1m0s
[21:59:19.527] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:175:0)
[21:59:19.527] Timer tick, asking Buildbucket for the build status
[21:59:19.717] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:19.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:176:0) after 1m0s
[22:00:19.775] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:176:0)
[22:00:19.775] Timer tick, asking Buildbucket for the build status
[22:00:19.927] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:19.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:177:0) after 1m0s
[22:01:19.960] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:177:0)
[22:01:19.960] Timer tick, asking Buildbucket for the build status
[22:01:20.040] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:20.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:178:0) after 1m0s
[22:02:20.069] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:178:0)
[22:02:20.069] Timer tick, asking Buildbucket for the build status
[22:02:20.140] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:20.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:179:0) after 1m0s
[22:03:20.170] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:179:0)
[22:03:20.170] Timer tick, asking Buildbucket for the build status
[22:03:20.267] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:20.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:180:0) after 1m0s
[22:04:20.303] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:180:0)
[22:04:20.303] Timer tick, asking Buildbucket for the build status
[22:04:20.569] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:20.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:181:0) after 1m0s
[22:05:20.628] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:181:0)
[22:05:20.629] Timer tick, asking Buildbucket for the build status
[22:05:20.867] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:20.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:182:0) after 1m0s
[22:06:20.895] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:182:0)
[22:06:20.895] Timer tick, asking Buildbucket for the build status
[22:06:20.960] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:20.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:183:0) after 1m0s
[22:07:21.000] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:183:0)
[22:07:21.000] Timer tick, asking Buildbucket for the build status
[22:07:21.210] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:21.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:184:0) after 1m0s
[22:08:21.238] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:184:0)
[22:08:21.238] Timer tick, asking Buildbucket for the build status
[22:08:21.331] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:185:0) after 1m0s
[22:09:21.362] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:185:0)
[22:09:21.362] Timer tick, asking Buildbucket for the build status
[22:09:21.488] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:21.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:186:0) after 1m0s
[22:10:21.584] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:186:0)
[22:10:21.584] Timer tick, asking Buildbucket for the build status
[22:10:21.642] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:21.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:187:0) after 1m0s
[22:11:21.670] Handling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:187:0)
[22:11:21.670] Timer tick, asking Buildbucket for the build status
[22:11:21.791] Build 8926866673054564272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:21.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-code-coverage:9092296735276495600:188:0) after 1m0s
[22:11:22.620] Received PubSub notification, asking Buildbucket for the build status
[22:11:22.653] Build 8926866673054564272: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "CANCELED_EXPLICITLY"
[22:11:22.653] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"cancelation_reason": "CANCELED_EXPLICITLY",
"completed_ts": "1545084623759245",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1545073550132381",
"id": "8926866673054564272",
"parameters_json": "{\"builder_name\": \"linux-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ddb92bdd44ce9dcbad4769ab4b90ec53940518a3\"}}",
"project": "chromium",
"result": "CANCELED",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-highmem-32\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"linux-code-coverage\"], \"kvm\": [\"1\"], \"ssd\": [\"1\"], \"id\": [\"gce-trusty-32-ssd-313e9fb8-us-east1-b-nk5x\"], \"server_version\": [\"3945-402d3be\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"32\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_f0e85433ca60e21ba10033b857841d88af052436c6cb8411b561ff60a2c00a4a_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1545073634800244",
"status": "COMPLETED",
"status_changed_ts": "1545084682054478",
"tags": [
"build_address:luci.chromium.ci/linux-code-coverage/1496",
"builder:linux-code-coverage",
"buildset:commit/git/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9092296735276495600",
"scheduler_job_id:chromium/linux-code-coverage",
"swarming_dimension:builder:linux-code-coverage",
"swarming_dimension:caches:builder_f0e85433ca60e21ba10033b857841d88af052436c6cb8411b561ff60a2c00a4a_v2",
"swarming_dimension:cores:32",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/linux-code-coverage/1496",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8926866673054564272",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
"swarming_tag:builder:linux-code-coverage",
"swarming_tag:buildset:commit/git/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddb92bdd44ce9dcbad4769ab4b90ec53940518a3",
"swarming_tag:caches:builder_f0e85433ca60e21ba10033b857841d88af052436c6cb8411b561ff60a2c00a4a_v2",
"swarming_tag:cores:32",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8926866673054564272/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9092296735276495600",
"swarming_tag:scheduler_job_id:chromium/linux-code-coverage",
"swarming_tag:service_account:chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:f86ec1ccbac5d2a2a6efc116e37c5e0761c3764b",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41d660ed6ff12e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1545084682108438",
"url": "https://ci.chromium.org/b/8926866673054564272",
"utcnow_ts": "1545084682645000"
}
}
[22:11:22.653] Invocation finished in 3h5m34.022386597s with status FAILED