[14:38:50.073] New invocation is queued and will start shortly
[14:38:51.187] Starting the invocation (attempt 1)
[14:38:51.227] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:38:51.227] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:38:51.227] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031613564479915520",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"21dbf6bddb3356b0882fa7b3bbf02d758e2dd271\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9031613564479915520",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/21dbf6bddb3356b0882fa7b3bbf02d758e2dd271",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21dbf6bddb3356b0882fa7b3bbf02d758e2dd271",
"gitiles_ref:refs/heads/master"
]
}
[14:38:52.098] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602945531343308",
"id": "8866183502484285472",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21dbf6bddb3356b0882fa7b3bbf02d758e2dd271\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602945531853501",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176762",
"builder:Linux Builder (dbg)",
"buildset:commit/git/21dbf6bddb3356b0882fa7b3bbf02d758e2dd271",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21dbf6bddb3356b0882fa7b3bbf02d758e2dd271",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031613564479915520",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8866183502484285472/+/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": "1602945531854238",
"url": "https://ci.chromium.org/b/8866183502484285472",
"utcnow_ts": "1602945532086239"
}
}
[14:38:52.098] Task URL: https://ci.chromium.org/b/8866183502484285472
[14:38:52.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:2:0) after 1m0s
[14:39:52.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:2:0)
[14:39:52.144] Timer tick, asking Buildbucket for the build status
[14:39:52.273] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:39:52.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:3:0) after 1m0s
[14:40:52.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:3:0)
[14:40:52.380] Timer tick, asking Buildbucket for the build status
[14:40:52.449] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:40:52.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:4:0) after 1m0s
[14:41:52.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:4:0)
[14:41:52.638] Timer tick, asking Buildbucket for the build status
[14:41:52.737] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:41:52.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:5:0) after 1m0s
[14:42:52.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:5:0)
[14:42:52.817] Timer tick, asking Buildbucket for the build status
[14:42:52.921] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:42:52.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:6:0) after 1m0s
[14:43:53.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:6:0)
[14:43:53.082] Timer tick, asking Buildbucket for the build status
[14:43:53.188] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:43:53.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:7:0) after 1m0s
[14:44:53.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:7:0)
[14:44:53.283] Timer tick, asking Buildbucket for the build status
[14:44:53.365] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:44:53.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:8:0) after 1m0s
[14:45:53.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:8:0)
[14:45:53.434] Timer tick, asking Buildbucket for the build status
[14:45:53.512] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:45:53.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:9:0) after 1m0s
[14:46:53.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:9:0)
[14:46:53.551] Timer tick, asking Buildbucket for the build status
[14:46:53.620] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:46:53.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:10:0) after 1m0s
[14:47:53.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:10:0)
[14:47:53.663] Timer tick, asking Buildbucket for the build status
[14:47:53.739] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:47:53.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:11:0) after 1m0s
[14:48:53.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:11:0)
[14:48:53.888] Timer tick, asking Buildbucket for the build status
[14:48:53.988] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:48:53.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:12:0) after 1m0s
[14:49:54.186] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:12:0)
[14:49:54.186] Timer tick, asking Buildbucket for the build status
[14:49:54.274] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:49:54.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:13:0) after 1m0s
[14:50:54.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:13:0)
[14:50:54.320] Timer tick, asking Buildbucket for the build status
[14:50:54.412] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:50:54.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:14:0) after 1m0s
[14:51:54.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:14:0)
[14:51:54.436] Timer tick, asking Buildbucket for the build status
[14:51:54.510] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:51:54.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:15:0) after 1m0s
[14:52:54.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:15:0)
[14:52:54.583] Timer tick, asking Buildbucket for the build status
[14:52:54.669] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:52:54.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:16:0) after 1m0s
[14:53:54.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:16:0)
[14:53:54.740] Timer tick, asking Buildbucket for the build status
[14:53:54.877] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:53:54.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:17:0) after 1m0s
[14:54:54.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:17:0)
[14:54:54.894] Timer tick, asking Buildbucket for the build status
[14:54:54.968] Build 8866183502484285472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:54.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:18:0) after 1m0s
[14:55:38.283] Received PubSub notification, asking Buildbucket for the build status
[14:55:38.354] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:54.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:18:0)
[14:55:54.992] Timer tick, asking Buildbucket for the build status
[14:55:55.076] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:55.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:20:0) after 1m0s
[14:56:55.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:20:0)
[14:56:55.102] Timer tick, asking Buildbucket for the build status
[14:56:55.189] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:55.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:21:0) after 1m0s
[14:57:55.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:21:0)
[14:57:55.281] Timer tick, asking Buildbucket for the build status
[14:57:55.362] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:55.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:22:0) after 1m0s
[14:58:55.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:22:0)
[14:58:55.409] Timer tick, asking Buildbucket for the build status
[14:58:55.515] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:55.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:23:0) after 1m0s
[14:59:55.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:23:0)
[14:59:55.613] Timer tick, asking Buildbucket for the build status
[14:59:55.703] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:55.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:24:0) after 1m0s
[15:00:55.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:24:0)
[15:00:55.879] Timer tick, asking Buildbucket for the build status
[15:00:56.112] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:56.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:25:0) after 1m0s
[15:01:56.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:25:0)
[15:01:56.162] Timer tick, asking Buildbucket for the build status
[15:01:56.299] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:56.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:26:0) after 1m0s
[15:02:56.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:26:0)
[15:02:56.367] Timer tick, asking Buildbucket for the build status
[15:02:56.635] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:56.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:27:0) after 1m0s
[15:03:56.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:27:0)
[15:03:56.664] Timer tick, asking Buildbucket for the build status
[15:03:56.860] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:56.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:28:0) after 1m0s
[15:04:56.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:28:0)
[15:04:56.942] Timer tick, asking Buildbucket for the build status
[15:04:57.301] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:57.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:29:0) after 1m0s
[15:05:57.332] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:29:0)
[15:05:57.332] Timer tick, asking Buildbucket for the build status
[15:05:57.392] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:57.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:30:0) after 1m0s
[15:06:57.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:30:0)
[15:06:57.435] Timer tick, asking Buildbucket for the build status
[15:06:57.506] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:57.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:31:0) after 1m0s
[15:07:57.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:31:0)
[15:07:57.536] Timer tick, asking Buildbucket for the build status
[15:07:57.681] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:57.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:32:0) after 1m0s
[15:08:57.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:32:0)
[15:08:57.708] Timer tick, asking Buildbucket for the build status
[15:08:57.815] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:57.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:33:0) after 1m0s
[15:09:57.897] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:33:0)
[15:09:57.897] Timer tick, asking Buildbucket for the build status
[15:09:58.269] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:58.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:34:0) after 1m0s
[15:10:58.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:34:0)
[15:10:58.423] Timer tick, asking Buildbucket for the build status
[15:10:58.706] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:58.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:35:0) after 1m0s
[15:11:58.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:35:0)
[15:11:58.811] Timer tick, asking Buildbucket for the build status
[15:11:58.870] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:58.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:36:0) after 1m0s
[15:12:58.897] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:36:0)
[15:12:58.897] Timer tick, asking Buildbucket for the build status
[15:12:58.958] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:58.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:37:0) after 1m0s
[15:13:58.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:37:0)
[15:13:58.992] Timer tick, asking Buildbucket for the build status
[15:13:59.113] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:59.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:38:0) after 1m0s
[15:14:59.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:38:0)
[15:14:59.092] Timer tick, asking Buildbucket for the build status
[15:14:59.374] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:59.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:39:0) after 1m0s
[15:15:59.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:39:0)
[15:15:59.495] Timer tick, asking Buildbucket for the build status
[15:15:59.635] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:59.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:40:0) after 1m0s
[15:16:59.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:40:0)
[15:16:59.655] Timer tick, asking Buildbucket for the build status
[15:16:59.873] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:59.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:41:0) after 1m0s
[15:17:59.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:41:0)
[15:17:59.898] Timer tick, asking Buildbucket for the build status
[15:17:59.975] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:59.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:42:0) after 1m0s
[15:19:00.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:42:0)
[15:19:00.072] Timer tick, asking Buildbucket for the build status
[15:19:00.305] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:00.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:43:0) after 1m0s
[15:20:00.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:43:0)
[15:20:00.327] Timer tick, asking Buildbucket for the build status
[15:20:00.387] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:00.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:44:0) after 1m0s
[15:21:00.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:44:0)
[15:21:00.476] Timer tick, asking Buildbucket for the build status
[15:21:00.621] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:00.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:45:0) after 1m0s
[15:22:00.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:45:0)
[15:22:00.641] Timer tick, asking Buildbucket for the build status
[15:22:00.710] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:00.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:46:0) after 1m0s
[15:23:00.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:46:0)
[15:23:00.763] Timer tick, asking Buildbucket for the build status
[15:23:00.825] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:00.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:47:0) after 1m0s
[15:24:01.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:47:0)
[15:24:01.540] Timer tick, asking Buildbucket for the build status
[15:24:01.777] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:01.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:48:0) after 1m0s
[15:25:02.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:48:0)
[15:25:02.728] Timer tick, asking Buildbucket for the build status
[15:25:02.809] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:02.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:49:0) after 1m0s
[15:26:02.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:49:0)
[15:26:02.794] Timer tick, asking Buildbucket for the build status
[15:26:02.866] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:02.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:50:0) after 1m0s
[15:27:02.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:50:0)
[15:27:02.982] Timer tick, asking Buildbucket for the build status
[15:27:03.178] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:03.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:51:0) after 1m0s
[15:28:03.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:51:0)
[15:28:03.211] Timer tick, asking Buildbucket for the build status
[15:28:03.386] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:03.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:52:0) after 1m0s
[15:29:03.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:52:0)
[15:29:03.407] Timer tick, asking Buildbucket for the build status
[15:29:03.824] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:03.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:53:0) after 1m0s
[15:30:03.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:53:0)
[15:30:03.903] Timer tick, asking Buildbucket for the build status
[15:30:04.041] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:04.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:54:0) after 1m0s
[15:31:04.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:54:0)
[15:31:04.117] Timer tick, asking Buildbucket for the build status
[15:31:04.310] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:04.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:55:0) after 1m0s
[15:32:04.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:55:0)
[15:32:04.431] Timer tick, asking Buildbucket for the build status
[15:32:04.502] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:04.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:56:0) after 1m0s
[15:33:04.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:56:0)
[15:33:04.500] Timer tick, asking Buildbucket for the build status
[15:33:04.564] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:04.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:57:0) after 1m0s
[15:34:04.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:57:0)
[15:34:04.568] Timer tick, asking Buildbucket for the build status
[15:34:04.688] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:04.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:58:0) after 1m0s
[15:35:04.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:58:0)
[15:35:04.711] Timer tick, asking Buildbucket for the build status
[15:35:04.777] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:04.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:59:0) after 1m0s
[15:36:04.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:59:0)
[15:36:04.818] Timer tick, asking Buildbucket for the build status
[15:36:05.471] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:05.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:60:0) after 1m0s
[15:37:05.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:60:0)
[15:37:05.785] Timer tick, asking Buildbucket for the build status
[15:37:05.847] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:05.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:61:0) after 1m0s
[15:38:05.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:61:0)
[15:38:05.960] Timer tick, asking Buildbucket for the build status
[15:38:08.432] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:08.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:62:0) after 1m0s
[15:39:08.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:62:0)
[15:39:08.491] Timer tick, asking Buildbucket for the build status
[15:39:08.615] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:08.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:63:0) after 1m0s
[15:40:08.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:63:0)
[15:40:08.686] Timer tick, asking Buildbucket for the build status
[15:40:08.758] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:08.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:64:0) after 1m0s
[15:41:08.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:64:0)
[15:41:08.748] Timer tick, asking Buildbucket for the build status
[15:41:08.822] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:08.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:65:0) after 1m0s
[15:42:09.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:65:0)
[15:42:09.097] Timer tick, asking Buildbucket for the build status
[15:42:09.173] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:09.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:66:0) after 1m0s
[15:43:09.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:66:0)
[15:43:09.293] Timer tick, asking Buildbucket for the build status
[15:43:09.360] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:09.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:67:0) after 1m0s
[15:44:09.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:67:0)
[15:44:09.473] Timer tick, asking Buildbucket for the build status
[15:44:10.088] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:10.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:68:0) after 1m0s
[15:45:10.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:68:0)
[15:45:10.197] Timer tick, asking Buildbucket for the build status
[15:45:10.260] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:10.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:69:0) after 1m0s
[15:46:10.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:69:0)
[15:46:10.417] Timer tick, asking Buildbucket for the build status
[15:46:10.492] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:10.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:70:0) after 1m0s
[15:47:10.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:70:0)
[15:47:10.572] Timer tick, asking Buildbucket for the build status
[15:47:10.872] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:10.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:71:0) after 1m0s
[15:48:11.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:71:0)
[15:48:11.029] Timer tick, asking Buildbucket for the build status
[15:48:11.186] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:11.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:72:0) after 1m0s
[15:49:11.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:72:0)
[15:49:11.209] Timer tick, asking Buildbucket for the build status
[15:49:11.329] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:11.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:73:0) after 1m0s
[15:50:11.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:73:0)
[15:50:11.380] Timer tick, asking Buildbucket for the build status
[15:50:11.605] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:11.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:74:0) after 1m0s
[15:51:11.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:74:0)
[15:51:11.624] Timer tick, asking Buildbucket for the build status
[15:51:11.767] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:11.767] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:75:0) after 1m0s
[15:52:11.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:75:0)
[15:52:11.839] Timer tick, asking Buildbucket for the build status
[15:52:11.906] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:11.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:76:0) after 1m0s
[15:53:11.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:76:0)
[15:53:11.979] Timer tick, asking Buildbucket for the build status
[15:53:12.184] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:12.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:77:0) after 1m0s
[15:54:12.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:77:0)
[15:54:12.205] Timer tick, asking Buildbucket for the build status
[15:54:12.346] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:12.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:78:0) after 1m0s
[15:55:12.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:78:0)
[15:55:12.365] Timer tick, asking Buildbucket for the build status
[15:55:12.848] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:12.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:79:0) after 1m0s
[15:56:12.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:79:0)
[15:56:12.986] Timer tick, asking Buildbucket for the build status
[15:56:13.189] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:13.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:80:0) after 1m0s
[15:57:13.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:80:0)
[15:57:13.227] Timer tick, asking Buildbucket for the build status
[15:57:13.289] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:13.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:81:0) after 1m0s
[15:58:13.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:81:0)
[15:58:13.311] Timer tick, asking Buildbucket for the build status
[15:58:13.370] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:13.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:82:0) after 1m0s
[15:59:13.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:82:0)
[15:59:13.475] Timer tick, asking Buildbucket for the build status
[15:59:13.581] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:13.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:83:0) after 1m0s
[16:00:13.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:83:0)
[16:00:13.655] Timer tick, asking Buildbucket for the build status
[16:00:13.733] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:13.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:84:0) after 1m0s
[16:01:13.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:84:0)
[16:01:13.775] Timer tick, asking Buildbucket for the build status
[16:01:13.838] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:13.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:85:0) after 1m0s
[16:02:13.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:85:0)
[16:02:13.993] Timer tick, asking Buildbucket for the build status
[16:02:14.054] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:14.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:86:0) after 1m0s
[16:03:14.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:86:0)
[16:03:14.107] Timer tick, asking Buildbucket for the build status
[16:03:14.364] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:14.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:87:0) after 1m0s
[16:04:14.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:87:0)
[16:04:14.396] Timer tick, asking Buildbucket for the build status
[16:04:14.537] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:14.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:88:0) after 1m0s
[16:05:14.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:88:0)
[16:05:14.609] Timer tick, asking Buildbucket for the build status
[16:05:14.665] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:14.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:89:0) after 1m0s
[16:06:14.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:89:0)
[16:06:14.740] Timer tick, asking Buildbucket for the build status
[16:06:14.803] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:14.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:90:0) after 1m0s
[16:07:14.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:90:0)
[16:07:14.837] Timer tick, asking Buildbucket for the build status
[16:07:14.921] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:14.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:91:0) after 1m0s
[16:08:14.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:91:0)
[16:08:14.974] Timer tick, asking Buildbucket for the build status
[16:08:15.042] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:15.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:92:0) after 1m0s
[16:09:15.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:92:0)
[16:09:15.119] Timer tick, asking Buildbucket for the build status
[16:09:15.270] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:15.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:93:0) after 1m0s
[16:10:15.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:93:0)
[16:10:15.289] Timer tick, asking Buildbucket for the build status
[16:10:15.363] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:15.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:94:0) after 1m0s
[16:11:15.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:94:0)
[16:11:15.387] Timer tick, asking Buildbucket for the build status
[16:11:15.492] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:15.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:95:0) after 1m0s
[16:12:15.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:95:0)
[16:12:15.514] Timer tick, asking Buildbucket for the build status
[16:12:15.616] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:15.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:96:0) after 1m0s
[16:13:15.966] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:96:0)
[16:13:15.966] Timer tick, asking Buildbucket for the build status
[16:13:16.026] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:16.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:97:0) after 1m0s
[16:14:16.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:97:0)
[16:14:16.267] Timer tick, asking Buildbucket for the build status
[16:14:16.379] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:16.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:98:0) after 1m0s
[16:15:16.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:98:0)
[16:15:16.965] Timer tick, asking Buildbucket for the build status
[16:15:17.368] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:17.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:99:0) after 1m0s
[16:16:17.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:99:0)
[16:16:17.568] Timer tick, asking Buildbucket for the build status
[16:16:17.902] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:17.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:100:0) after 1m0s
[16:17:18.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:100:0)
[16:17:18.206] Timer tick, asking Buildbucket for the build status
[16:17:18.570] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:18.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:101:0) after 1m0s
[16:18:18.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:101:0)
[16:18:18.621] Timer tick, asking Buildbucket for the build status
[16:18:18.884] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:18.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:102:0) after 1m0s
[16:19:18.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:102:0)
[16:19:18.944] Timer tick, asking Buildbucket for the build status
[16:19:19.075] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:19.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:103:0) after 1m0s
[16:20:19.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:103:0)
[16:20:19.118] Timer tick, asking Buildbucket for the build status
[16:20:19.186] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:19.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:104:0) after 1m0s
[16:21:19.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:104:0)
[16:21:19.260] Timer tick, asking Buildbucket for the build status
[16:21:19.399] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:19.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:105:0) after 1m0s
[16:22:19.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:105:0)
[16:22:19.454] Timer tick, asking Buildbucket for the build status
[16:22:19.702] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:19.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:106:0) after 1m0s
[16:23:19.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:106:0)
[16:23:19.782] Timer tick, asking Buildbucket for the build status
[16:23:19.847] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:19.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:107:0) after 1m0s
[16:24:19.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:107:0)
[16:24:19.962] Timer tick, asking Buildbucket for the build status
[16:24:20.260] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:20.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:108:0) after 1m0s
[16:25:20.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:108:0)
[16:25:20.478] Timer tick, asking Buildbucket for the build status
[16:25:20.541] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:20.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:109:0) after 1m0s
[16:26:20.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:109:0)
[16:26:20.600] Timer tick, asking Buildbucket for the build status
[16:26:20.663] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:20.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:110:0) after 1m0s
[16:27:20.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:110:0)
[16:27:20.686] Timer tick, asking Buildbucket for the build status
[16:27:20.804] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:20.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:111:0) after 1m0s
[16:28:20.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:111:0)
[16:28:20.882] Timer tick, asking Buildbucket for the build status
[16:28:21.130] Build 8866183502484285472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:21.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031613564479915520:112:0) after 1m0s
[16:28:52.219] Received PubSub notification, asking Buildbucket for the build status
[16:28:52.506] Build 8866183502484285472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:28:52.507] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602952131120252",
"created_by": "project:chromium",
"created_ts": "1602945531343308",
"id": "8866183502484285472",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21dbf6bddb3356b0882fa7b3bbf02d758e2dd271\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"21dbf6bddb3356b0882fa7b3bbf02d758e2dd271\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-3-imik\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176762, \"got_angle_revision\": \"da09d08f0f7e362749f51e0e9dd26b3c3106c5e7\", \"got_dawn_revision\": \"875091308b04ba87e29c929ed707f27889c660ea\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"21dbf6bddb3356b0882fa7b3bbf02d758e2dd271\", \"got_revision_cp\": \"refs/heads/master@{#818249}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"992b13db26c29db225f812aa1dfc637940e99cb8\", \"got_v8_revision_cp\": \"refs/heads/8.8.119@{#1}\", \"got_webrtc_revision\": \"1f3ac1f8e0688f8eff467b7dedbdb3f202604aeb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32428}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21dbf6bddb3356b0882fa7b3bbf02d758e2dd271\", \"swarm_hashes_refs/heads/master(at){#818249}_without_patch\": {\"absl_hardening_tests\": \"8c748dea6bbe07f26f69bbb0534ab2ca0802e235\", \"accessibility_unittests\": \"6c11361fbe456ebc4fa946521b4ed7e5824a4644\", \"app_shell_unittests\": \"39c7aafbe11cd3c96877ed8659a4c01d9c059042\", \"aura_unittests\": \"1b13e7824f50f85b42c4cac30bce4a4302a8a037\", \"base_unittests\": \"d286f8ee5372dc718462fb5ab858cd2230620cb4\", \"base_util_unittests\": \"7a21595d9622f0e680a8ede465046a765522f5d6\", \"blink_common_unittests\": \"69637068d92f904e2637da84c3160b548d7d2638\", \"blink_fuzzer_unittests\": \"d45a5b9cc244802edd69e0798247779dcc32becc\", \"blink_heap_unittests\": \"36b192224ee40e625ca713366f464bc90e042e61\", \"blink_platform_unittests\": \"8942943a9158d56ae10636755a25217d5d1dcb44\", \"blink_python_tests\": \"7b08d15d0de5c74590b1c67f4ccc39f585f13593\", \"blink_unittests\": \"116e2c1602c317c8078019ba33d7e9b61d277284\", \"blink_web_tests\": \"763a6519957023d9240d5450e85f681b3c029002\", \"boringssl_crypto_tests\": \"0fd6d501297f9b35122b8b1fc22d6ffa9f5716df\", \"boringssl_ssl_tests\": \"11c1c60612d4931d02bebffaeab56bc0f6db3bc2\", \"browser_tests\": \"1d1a1b4a4f95ae75cd0f6b17cd9bd0615c158976\", \"capture_unittests\": \"28b55759a693c28124c46a5761a5d4a003a1c3ba\", \"cast_unittests\": \"2afb218175aef674598bfe643c3a9b84b9858cbe\", \"cc_unittests\": \"6f057f63186cdad24de0d73419cb9719f035bcf3\", \"chrome_app_unittests\": \"4358607cec7d6b234e1442b859fd73cad7945fb2\", \"chromedriver_unittests\": \"a21588db21f047b197b14c4fc7e9e0a8cd806d06\", \"components_browsertests\": \"5bd02429dad964e21551d2288b377c0a346cbb96\", \"components_unittests\": \"8ee7fe31f4508f4c693fadf1d7815a577e029128\", \"compositor_unittests\": \"8b0b61ffcd96697e6c495de4a5d3a1f66e52ea65\", \"content_browsertests\": \"29b230ac5f202bfa9a46f3fecb62ef28aa5952a3\", \"content_shell_crash_test\": \"11e225e8fe987060464b5d5242aa04669360f7fe\", \"content_unittests\": \"0bc532a9f471442401e1afac0ee6edf794b9dbe8\", \"crashpad_tests\": \"752fe1003c6647f9d2b2a3f878e489670a723e89\", \"cronet_tests\": \"2b0a08f89499152c260dec477328aec060df22ba\", \"cronet_unittests\": \"71320ba520d7f6e47fe81a4ab939df6ab77b6bb2\", \"crypto_unittests\": \"4503d96fbab2194e8ca8fbdb89b40a52965b397e\", \"dbus_unittests\": \"000c300753f39e25b4409c08220bd113d6f5a916\", \"device_unittests\": \"65c108db2e4f04e7de8eb32a95716b92f9ee8532\", \"display_unittests\": \"b14e32f30d3a1c6d9a465e5815d89ce8c8ec432c\", \"events_unittests\": \"b3dbd1fd62ccd98e4b5ad328d5111b15eb1a6565\", \"extension_docserver_python_unittests\": \"f63b04a390222006832c09a8c4a08547b12ede68\", \"extensions_browsertests\": \"fd54bba7f0168afa61fed8aadecbeca234fb0c9c\", \"extensions_unittests\": \"db477c6782f72a6c909f07d157a617925e16ad35\", \"filesystem_service_unittests\": \"cdb665810f94162515143f730d2f6a3650e82745\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"53c7b6d693fa95e0a9069520a7cf629da51da290\", \"gfx_unittests\": \"3343c3889e3d56f7e60dd0f408cbe90ed9ce2c03\", \"gin_unittests\": \"646a6ba99b9e3be9c60e32cf70c430e5f378e4e6\", \"google_apis_unittests\": \"6a392d34c03f57479d9929783451f09e0add432f\", \"gpu_unittests\": \"4b3c3d21df788d0a3535ceca73e7ca6554da3215\", \"grit_python_unittests\": \"8ff0b3de600ef80bc443ec65457d74cd6c46cf1a\", \"gwp_asan_unittests\": \"55205d0e6329790ce4aca4de94d08c4691355d45\", \"headless_browsertests\": \"918a7117f9f8e863d3e0fd3f6b1c0b92878da140\", \"headless_unittests\": \"d7f46a9f4006501ccce95d76d000f41867f6b10c\", \"interactive_ui_tests\": \"56cb8f48dad66ecdac0239890c19562d06cb52cd\", \"ipc_tests\": \"5b4fbdb06742d83721739a4cc838bfe8fb988483\", \"jingle_unittests\": \"93e2613b9a088c373b6869b6b6f4ebf8bf31c648\", \"latency_unittests\": \"b366f4a9b5b556da75b473190bcfd82968c121ca\", \"libjingle_xmpp_unittests\": \"1e3109545c3d9acd8875b41830072fe4046da029\", \"media_blink_unittests\": \"ac2eb58a49cbca2a540654160ee5cd25a45bddf6\", \"media_unittests\": \"3dd47807a848efdff4779ae603171970189f4a18\", \"message_center_unittests\": \"a478bd97fdfd74d7274acba44c034f646c55c97a\", \"metrics_python_tests\": \"529514dacf9f4b326e8edd62e33ab2deca863d72\", \"midi_unittests\": \"10eb3293d010323375430ac5195c93d722f56167\", \"mojo_core_unittests\": \"4b58deaddd6850d5b17c3d8daa3c8972823313de\", \"mojo_unittests\": \"a1815410ebdcb99a3fd71d21dd4c89a315ebb498\", \"nacl_helper_nonsfi_unittests\": \"d9859e85487baf3329eb88c32ef93b6374171718\", \"nacl_loader_unittests\": \"6a900b2bfdf0f32f0cac7e1bd40736fe7dd2eb58\", \"native_theme_unittests\": \"69d19b7ce963a2d11652f507f05015ce110819db\", \"net_unittests\": \"5ca7683ef02543e1fbf113407d750e9425f34f13\", \"openscreen_unittests\": \"765f7b25cfbe3ac7ba5dbad8484d79951a36f41b\", \"pdf_unittests\": \"fa08ba641a1c1eb612b14fdf05eb5bb538d54ee6\", \"perfetto_unittests\": \"7b094148c0d45588f4c1cbba2227ad6f429d20ae\", \"ppapi_unittests\": \"beadb693870bbb2bc92db0de107e26b96008502d\", \"printing_unittests\": \"ecc8f9bfdab7a345bb9578bb89420a1c099cd34d\", \"remoting_unittests\": \"595feaaea6a39604040b402560cb90d661d5097f\", \"sandbox_linux_unittests\": \"c167d9018dd3a21484a873e0e6a21aad537ae731\", \"service_manager_unittests\": \"ace60da06e2d068009dd979802b337b2f7b96141\", \"services_unittests\": \"cbb987d2e0e53b2450bab8b83c738ea36daa25a4\", \"shell_dialogs_unittests\": \"2f800b0e6bc803b818b834f3210e6ff17d7208b2\", \"skia_unittests\": \"b5f0d60de13038f6bff6934fab885c418017b892\", \"snapshot_unittests\": \"7d93ce024bcaf5a27347f997e2bc9b602d1554da\", \"sql_unittests\": \"f0d34b31f6a8c2963c049bf993045002b4f1b77a\", \"standalone_angle_unittests\": \"07d20466cdaff61f74cc48dfc7b0496cee643cd3\", \"storage_unittests\": \"a3f2091e168838ac0161ade4c4617f242337232a\", \"sync_integration_tests\": \"7fab51bc7bdfa5f6d099c4916f68d9899b05c24b\", \"telemetry_gpu_unittests\": \"935d2fa3c1dcae561fc94b026f39402ccf9c1d38\", \"telemetry_perf_unittests\": \"4a7006d92dacabdac23118ca2ead747244b1a030\", \"telemetry_unittests\": \"3ede6feceaf10303b2857ea57d3f83bba004e55e\", \"traffic_annotation_auditor_unittests\": \"697ce2597f5f6f5fa0220f9e70f4f58962c4b524\", \"ui_base_unittests\": \"53c266e789902c619f0a734b87eee139585c2798\", \"ui_touch_selection_unittests\": \"526f81a0b5a39d2ec72501e63042b7762f8f71bb\", \"unit_tests\": \"aeb29c7bbaadb5d8a3f0a88408a21c53f99f5741\", \"url_unittests\": \"e6b828cced0ea81fe2872a0353421972aa2bb4f5\", \"views_perftests\": \"92818c08b84b22439ab61d4566e1b02de50988cf\", \"views_unittests\": \"be91e531a356ff0f8983f2ce8af973ed387fec3a\", \"viz_unittests\": \"79c213dabcb6f7a259200bb096247c562699cf35\", \"vr_common_unittests\": \"193d52b934848a1b0fa868bd103f6a5ccf0bc752\", \"vr_pixeltests\": \"40414aee09b4a5c4445abc1697528aa5f7b1622d\", \"webdriver_wpt_tests\": \"8977bb53f2a762a354e7c8c97b7232b0a56909bb\", \"weblayer_browsertests\": \"8582405ca927a871d33432cd5439170c656671dc\", \"weblayer_unittests\": \"e3eb13cfcb3d811c5bb96410fccddfdb5c73cce7\", \"wm_unittests\": \"7a0af6ade74b4dfe36920521d7bdcc81062e962e\", \"wtf_unittests\": \"75f45e40e523c85e1df113aa9cec1962ee585045\", \"x11_unittests\": \"0c49b4c8d58209f384ecdcae7f1aced49d8067a1\", \"xr_browser_tests\": \"81415d89c80de824e0bfb48a1576ae446a20f70a\", \"zlib_unittests\": \"229cca615d3d9ec6ca52b3ad1ecb580e66e5a383\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02b94346fc981ed3c3847ac0524bcc084571ef426302b2a255781857b227612a_v2\", \"builder_279625ee090c361ea8cf031374b7b020d1191c526e0ef1068ab634999c69ee70_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_b73f380ff82aebbfe08c374279666467ed7ae9f4699bdf686b893daa00950c8e_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-3-imik\"], \"image\": [\"chrome-xenial-20101301-f14f52fdd71\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5595-820ff29\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602946517935206",
"status": "COMPLETED",
"status_changed_ts": "1602952131479873",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176762",
"builder:Linux Builder (dbg)",
"buildset:commit/git/21dbf6bddb3356b0882fa7b3bbf02d758e2dd271",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21dbf6bddb3356b0882fa7b3bbf02d758e2dd271",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031613564479915520",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8866183502484285472/+/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:4f4fd14905e47010",
"user_agent:luci-scheduler"
],
"updated_ts": "1602952131489246",
"url": "https://ci.chromium.org/b/8866183502484285472",
"utcnow_ts": "1602952132495151"
}
}
[16:28:52.507] Invocation finished in 1h50m2.449894064s with status SUCCEEDED