[08:09:04.775] New invocation is queued and will start shortly
[08:09:05.957] Starting the invocation (attempt 1)
[08:09:05.991] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:09:05.991] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:09:05.991] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020857046739787408",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f6f1edae86761b39e766ec8c403a6bdb8c0bab81\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9020857046739787408",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f6f1edae86761b39e766ec8c403a6bdb8c0bab81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f6f1edae86761b39e766ec8c403a6bdb8c0bab81",
"gitiles_ref:refs/heads/master"
]
}
[08:09:07.179] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613203746127708",
"id": "8855426984658893616",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f6f1edae86761b39e766ec8c403a6bdb8c0bab81\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613203746978256",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180550",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f6f1edae86761b39e766ec8c403a6bdb8c0bab81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f6f1edae86761b39e766ec8c403a6bdb8c0bab81",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020857046739787408",
"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/8855426984658893616/+/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": "1613203746978400",
"url": "https://ci.chromium.org/b/8855426984658893616",
"utcnow_ts": "1613203747153301"
}
}
[08:09:07.179] Task URL: https://ci.chromium.org/b/8855426984658893616
[08:09:07.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:2:0) after 1m0s
[08:10:07.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:2:0)
[08:10:07.258] Timer tick, asking Buildbucket for the build status
[08:10:07.364] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:07.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:3:0) after 1m0s
[08:11:07.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:3:0)
[08:11:07.787] Timer tick, asking Buildbucket for the build status
[08:11:07.864] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:11:07.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:4:0) after 1m0s
[08:12:07.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:4:0)
[08:12:07.983] Timer tick, asking Buildbucket for the build status
[08:12:08.217] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:12:08.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:5:0) after 1m0s
[08:13:08.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:5:0)
[08:13:08.341] Timer tick, asking Buildbucket for the build status
[08:13:08.426] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:13:08.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:6:0) after 1m0s
[08:14:08.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:6:0)
[08:14:08.501] Timer tick, asking Buildbucket for the build status
[08:14:08.644] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:08.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:7:0) after 1m0s
[08:15:08.767] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:7:0)
[08:15:08.767] Timer tick, asking Buildbucket for the build status
[08:15:08.845] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:08.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:8:0) after 1m0s
[08:16:08.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:8:0)
[08:16:08.862] Timer tick, asking Buildbucket for the build status
[08:16:09.298] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:09.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:9:0) after 1m0s
[08:17:09.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:9:0)
[08:17:09.316] Timer tick, asking Buildbucket for the build status
[08:17:09.445] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:09.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:10:0) after 1m0s
[08:18:09.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:10:0)
[08:18:09.507] Timer tick, asking Buildbucket for the build status
[08:18:09.597] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:18:09.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:11:0) after 1m0s
[08:19:09.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:11:0)
[08:19:09.638] Timer tick, asking Buildbucket for the build status
[08:19:09.802] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:19:09.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:12:0) after 1m0s
[08:20:09.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:12:0)
[08:20:09.868] Timer tick, asking Buildbucket for the build status
[08:20:09.942] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:20:09.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:13:0) after 1m0s
[08:21:09.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:13:0)
[08:21:09.961] Timer tick, asking Buildbucket for the build status
[08:21:10.121] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:21:10.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:14:0) after 1m0s
[08:22:10.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:14:0)
[08:22:10.101] Timer tick, asking Buildbucket for the build status
[08:22:10.168] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:22:10.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:15:0) after 1m0s
[08:23:10.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:15:0)
[08:23:10.184] Timer tick, asking Buildbucket for the build status
[08:23:10.428] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:23:10.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:16:0) after 1m0s
[08:24:10.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:16:0)
[08:24:10.454] Timer tick, asking Buildbucket for the build status
[08:24:10.566] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:10.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:17:0) after 1m0s
[08:25:10.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:17:0)
[08:25:10.585] Timer tick, asking Buildbucket for the build status
[08:25:10.661] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:10.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:18:0) after 1m0s
[08:26:10.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:18:0)
[08:26:10.812] Timer tick, asking Buildbucket for the build status
[08:26:10.892] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:10.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:19:0) after 1m0s
[08:27:10.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:19:0)
[08:27:10.963] Timer tick, asking Buildbucket for the build status
[08:27:11.029] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:11.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:20:0) after 1m0s
[08:28:11.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:20:0)
[08:28:11.078] Timer tick, asking Buildbucket for the build status
[08:28:11.146] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:11.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:21:0) after 1m0s
[08:29:11.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:21:0)
[08:29:11.236] Timer tick, asking Buildbucket for the build status
[08:29:11.316] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:11.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:22:0) after 1m0s
[08:30:11.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:22:0)
[08:30:11.355] Timer tick, asking Buildbucket for the build status
[08:30:11.434] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:11.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:23:0) after 1m0s
[08:31:11.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:23:0)
[08:31:11.444] Timer tick, asking Buildbucket for the build status
[08:31:11.523] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:31:11.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:24:0) after 1m0s
[08:32:11.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:24:0)
[08:32:11.573] Timer tick, asking Buildbucket for the build status
[08:32:11.644] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:32:11.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:25:0) after 1m0s
[08:33:11.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:25:0)
[08:33:11.711] Timer tick, asking Buildbucket for the build status
[08:33:11.783] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:33:11.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:26:0) after 1m0s
[08:34:11.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:26:0)
[08:34:11.837] Timer tick, asking Buildbucket for the build status
[08:34:11.936] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:34:11.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:27:0) after 1m0s
[08:35:11.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:27:0)
[08:35:11.987] Timer tick, asking Buildbucket for the build status
[08:35:12.065] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:12.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:28:0) after 1m0s
[08:36:12.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:28:0)
[08:36:12.128] Timer tick, asking Buildbucket for the build status
[08:36:12.203] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:12.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:29:0) after 1m0s
[08:37:12.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:29:0)
[08:37:12.223] Timer tick, asking Buildbucket for the build status
[08:37:12.427] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:12.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:30:0) after 1m0s
[08:38:12.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:30:0)
[08:38:12.447] Timer tick, asking Buildbucket for the build status
[08:38:12.555] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:12.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:31:0) after 1m0s
[08:39:12.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:31:0)
[08:39:12.572] Timer tick, asking Buildbucket for the build status
[08:39:12.668] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:12.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:32:0) after 1m0s
[08:40:12.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:32:0)
[08:40:12.685] Timer tick, asking Buildbucket for the build status
[08:40:12.757] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:40:12.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:33:0) after 1m0s
[08:41:12.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:33:0)
[08:41:12.776] Timer tick, asking Buildbucket for the build status
[08:41:12.836] Build 8855426984658893616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:41:12.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:34:0) after 1m0s
[08:42:02.495] Received PubSub notification, asking Buildbucket for the build status
[08:42:04.703] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:12.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:34:0)
[08:42:12.854] Timer tick, asking Buildbucket for the build status
[08:42:12.929] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:12.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:36:0) after 1m0s
[08:43:12.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:36:0)
[08:43:12.928] Timer tick, asking Buildbucket for the build status
[08:43:13.003] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:13.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:37:0) after 1m0s
[08:44:13.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:37:0)
[08:44:13.020] Timer tick, asking Buildbucket for the build status
[08:44:13.109] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:13.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:38:0) after 1m0s
[08:45:13.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:38:0)
[08:45:13.204] Timer tick, asking Buildbucket for the build status
[08:45:13.323] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:13.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:39:0) after 1m0s
[08:46:13.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:39:0)
[08:46:13.354] Timer tick, asking Buildbucket for the build status
[08:46:13.432] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:13.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:40:0) after 1m0s
[08:47:13.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:40:0)
[08:47:13.451] Timer tick, asking Buildbucket for the build status
[08:47:13.579] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:13.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:41:0) after 1m0s
[08:48:13.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:41:0)
[08:48:13.599] Timer tick, asking Buildbucket for the build status
[08:48:13.720] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:13.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:42:0) after 1m0s
[08:49:13.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:42:0)
[08:49:13.707] Timer tick, asking Buildbucket for the build status
[08:49:13.815] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:13.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:43:0) after 1m0s
[08:50:13.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:43:0)
[08:50:13.851] Timer tick, asking Buildbucket for the build status
[08:50:14.121] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:14.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:44:0) after 1m0s
[08:51:14.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:44:0)
[08:51:14.170] Timer tick, asking Buildbucket for the build status
[08:51:14.240] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:14.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:45:0) after 1m0s
[08:52:14.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:45:0)
[08:52:14.257] Timer tick, asking Buildbucket for the build status
[08:52:14.666] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:14.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:46:0) after 1m0s
[08:53:14.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:46:0)
[08:53:14.693] Timer tick, asking Buildbucket for the build status
[08:53:14.766] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:14.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:47:0) after 1m0s
[08:54:14.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:47:0)
[08:54:14.782] Timer tick, asking Buildbucket for the build status
[08:54:14.881] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:14.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:48:0) after 1m0s
[08:55:14.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:48:0)
[08:55:14.927] Timer tick, asking Buildbucket for the build status
[08:55:14.989] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:14.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:49:0) after 1m0s
[08:56:15.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:49:0)
[08:56:15.014] Timer tick, asking Buildbucket for the build status
[08:56:15.297] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:15.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:50:0) after 1m0s
[08:57:15.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:50:0)
[08:57:15.323] Timer tick, asking Buildbucket for the build status
[08:57:15.555] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:15.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:51:0) after 1m0s
[08:58:15.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:51:0)
[08:58:15.641] Timer tick, asking Buildbucket for the build status
[08:58:15.741] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:15.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:52:0) after 1m0s
[08:59:15.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:52:0)
[08:59:15.871] Timer tick, asking Buildbucket for the build status
[08:59:16.208] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:16.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:53:0) after 1m0s
[09:00:16.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:53:0)
[09:00:16.233] Timer tick, asking Buildbucket for the build status
[09:00:16.446] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:16.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:54:0) after 1m0s
[09:01:16.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:54:0)
[09:01:16.444] Timer tick, asking Buildbucket for the build status
[09:01:16.638] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:16.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:55:0) after 1m0s
[09:02:16.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:55:0)
[09:02:16.666] Timer tick, asking Buildbucket for the build status
[09:02:16.796] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:16.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:56:0) after 1m0s
[09:03:16.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:56:0)
[09:03:16.832] Timer tick, asking Buildbucket for the build status
[09:03:17.187] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:17.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:57:0) after 1m0s
[09:04:17.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:57:0)
[09:04:17.212] Timer tick, asking Buildbucket for the build status
[09:04:17.311] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:17.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:58:0) after 1m0s
[09:05:17.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:58:0)
[09:05:17.364] Timer tick, asking Buildbucket for the build status
[09:05:17.440] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:17.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:59:0) after 1m0s
[09:06:17.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:59:0)
[09:06:17.528] Timer tick, asking Buildbucket for the build status
[09:06:17.602] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:17.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:60:0) after 1m0s
[09:07:17.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:60:0)
[09:07:17.621] Timer tick, asking Buildbucket for the build status
[09:07:17.693] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:17.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:61:0) after 1m0s
[09:08:17.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:61:0)
[09:08:17.717] Timer tick, asking Buildbucket for the build status
[09:08:17.802] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:17.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:62:0) after 1m0s
[09:09:17.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:62:0)
[09:09:17.821] Timer tick, asking Buildbucket for the build status
[09:09:17.913] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:17.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:63:0) after 1m0s
[09:10:17.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:63:0)
[09:10:17.930] Timer tick, asking Buildbucket for the build status
[09:10:18.524] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:18.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:64:0) after 1m0s
[09:11:18.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:64:0)
[09:11:18.589] Timer tick, asking Buildbucket for the build status
[09:11:18.988] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:18.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:65:0) after 1m0s
[09:12:18.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:65:0)
[09:12:18.969] Timer tick, asking Buildbucket for the build status
[09:12:19.061] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:19.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:66:0) after 1m0s
[09:13:19.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:66:0)
[09:13:19.130] Timer tick, asking Buildbucket for the build status
[09:13:19.218] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:19.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:67:0) after 1m0s
[09:14:19.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:67:0)
[09:14:19.229] Timer tick, asking Buildbucket for the build status
[09:14:19.322] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:19.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:68:0) after 1m0s
[09:15:19.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:68:0)
[09:15:19.376] Timer tick, asking Buildbucket for the build status
[09:15:19.475] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:19.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:69:0) after 1m0s
[09:16:19.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:69:0)
[09:16:19.543] Timer tick, asking Buildbucket for the build status
[09:16:19.628] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:19.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:70:0) after 1m0s
[09:17:19.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:70:0)
[09:17:19.702] Timer tick, asking Buildbucket for the build status
[09:17:19.786] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:19.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:71:0) after 1m0s
[09:18:19.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:71:0)
[09:18:19.819] Timer tick, asking Buildbucket for the build status
[09:18:19.892] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:19.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:72:0) after 1m0s
[09:19:19.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:72:0)
[09:19:19.911] Timer tick, asking Buildbucket for the build status
[09:19:20.014] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:20.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:73:0) after 1m0s
[09:20:19.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:73:0)
[09:20:19.999] Timer tick, asking Buildbucket for the build status
[09:20:20.091] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:20.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:74:0) after 1m0s
[09:21:20.120] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:74:0)
[09:21:20.120] Timer tick, asking Buildbucket for the build status
[09:21:20.216] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:20.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:75:0) after 1m0s
[09:22:20.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:75:0)
[09:22:20.337] Timer tick, asking Buildbucket for the build status
[09:22:20.438] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:20.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:76:0) after 1m0s
[09:23:25.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:76:0)
[09:23:25.080] Timer tick, asking Buildbucket for the build status
[09:23:25.153] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:25.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:77:0) after 1m0s
[09:24:25.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:77:0)
[09:24:25.177] Timer tick, asking Buildbucket for the build status
[09:24:25.394] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:25.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:78:0) after 1m0s
[09:25:25.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:78:0)
[09:25:25.501] Timer tick, asking Buildbucket for the build status
[09:25:25.597] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:25.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:79:0) after 1m0s
[09:26:25.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:79:0)
[09:26:25.616] Timer tick, asking Buildbucket for the build status
[09:26:25.689] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:25.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:80:0) after 1m0s
[09:27:25.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:80:0)
[09:27:25.723] Timer tick, asking Buildbucket for the build status
[09:27:25.810] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:25.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:81:0) after 1m0s
[09:28:25.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:81:0)
[09:28:25.848] Timer tick, asking Buildbucket for the build status
[09:28:26.309] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:26.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:82:0) after 1m0s
[09:29:26.332] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:82:0)
[09:29:26.332] Timer tick, asking Buildbucket for the build status
[09:29:26.587] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:26.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:83:0) after 1m0s
[09:30:26.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:83:0)
[09:30:26.623] Timer tick, asking Buildbucket for the build status
[09:30:26.894] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:26.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:84:0) after 1m0s
[09:31:26.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:84:0)
[09:31:26.916] Timer tick, asking Buildbucket for the build status
[09:31:27.003] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:27.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:85:0) after 1m0s
[09:32:27.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:85:0)
[09:32:27.023] Timer tick, asking Buildbucket for the build status
[09:32:27.200] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:27.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:86:0) after 1m0s
[09:33:27.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:86:0)
[09:33:27.223] Timer tick, asking Buildbucket for the build status
[09:33:27.809] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:27.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:87:0) after 1m0s
[09:34:27.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:87:0)
[09:34:27.809] Timer tick, asking Buildbucket for the build status
[09:34:27.904] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:27.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:88:0) after 1m0s
[09:35:28.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:88:0)
[09:35:28.002] Timer tick, asking Buildbucket for the build status
[09:35:28.102] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:28.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:89:0) after 1m0s
[09:36:28.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:89:0)
[09:36:28.122] Timer tick, asking Buildbucket for the build status
[09:36:28.220] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:28.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:90:0) after 1m0s
[09:37:28.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:90:0)
[09:37:28.293] Timer tick, asking Buildbucket for the build status
[09:37:28.516] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:28.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:91:0) after 1m0s
[09:38:28.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:91:0)
[09:38:28.538] Timer tick, asking Buildbucket for the build status
[09:38:28.752] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:28.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:92:0) after 1m0s
[09:39:28.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:92:0)
[09:39:28.748] Timer tick, asking Buildbucket for the build status
[09:39:29.133] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:29.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:93:0) after 1m0s
[09:40:29.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:93:0)
[09:40:29.187] Timer tick, asking Buildbucket for the build status
[09:40:29.438] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:29.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:94:0) after 1m0s
[09:41:29.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:94:0)
[09:41:29.504] Timer tick, asking Buildbucket for the build status
[09:41:29.846] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:29.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:95:0) after 1m0s
[09:42:29.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:95:0)
[09:42:29.941] Timer tick, asking Buildbucket for the build status
[09:42:30.195] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:30.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:96:0) after 1m0s
[09:43:30.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:96:0)
[09:43:30.255] Timer tick, asking Buildbucket for the build status
[09:43:30.475] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:30.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:97:0) after 1m0s
[09:44:30.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:97:0)
[09:44:30.497] Timer tick, asking Buildbucket for the build status
[09:44:30.699] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:30.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:98:0) after 1m0s
[09:45:30.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:98:0)
[09:45:30.743] Timer tick, asking Buildbucket for the build status
[09:45:31.068] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:31.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:99:0) after 1m0s
[09:46:31.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:99:0)
[09:46:31.164] Timer tick, asking Buildbucket for the build status
[09:46:31.455] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:31.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:100:0) after 1m0s
[09:47:31.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:100:0)
[09:47:31.520] Timer tick, asking Buildbucket for the build status
[09:47:31.606] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:31.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:101:0) after 1m0s
[09:48:31.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:101:0)
[09:48:31.946] Timer tick, asking Buildbucket for the build status
[09:48:32.022] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:32.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:102:0) after 1m0s
[09:49:32.202] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:102:0)
[09:49:32.202] Timer tick, asking Buildbucket for the build status
[09:49:32.329] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:32.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:103:0) after 1m0s
[09:50:32.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:103:0)
[09:50:32.388] Timer tick, asking Buildbucket for the build status
[09:50:32.455] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:32.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:104:0) after 1m0s
[09:51:32.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:104:0)
[09:51:32.510] Timer tick, asking Buildbucket for the build status
[09:51:32.660] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:32.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:105:0) after 1m0s
[09:52:32.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:105:0)
[09:52:32.786] Timer tick, asking Buildbucket for the build status
[09:52:32.881] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:32.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:106:0) after 1m0s
[09:53:32.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:106:0)
[09:53:32.855] Timer tick, asking Buildbucket for the build status
[09:53:32.955] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:32.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:107:0) after 1m0s
[09:54:33.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:107:0)
[09:54:33.012] Timer tick, asking Buildbucket for the build status
[09:54:33.100] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:33.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:108:0) after 1m0s
[09:55:33.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:108:0)
[09:55:33.129] Timer tick, asking Buildbucket for the build status
[09:55:33.408] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:33.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:109:0) after 1m0s
[09:56:33.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:109:0)
[09:56:33.490] Timer tick, asking Buildbucket for the build status
[09:56:33.566] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:33.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:110:0) after 1m0s
[09:57:34.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:110:0)
[09:57:34.424] Timer tick, asking Buildbucket for the build status
[09:57:34.524] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:34.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:111:0) after 1m0s
[09:58:34.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:111:0)
[09:58:34.550] Timer tick, asking Buildbucket for the build status
[09:58:35.375] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:35.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:112:0) after 1m0s
[09:59:35.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:112:0)
[09:59:35.426] Timer tick, asking Buildbucket for the build status
[09:59:35.858] Build 8855426984658893616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:35.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020857046739787408:113:0) after 1m0s
[09:59:38.602] Received PubSub notification, asking Buildbucket for the build status
[09:59:38.684] Build 8855426984658893616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:59:38.684] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613210377925026",
"created_by": "project:chromium",
"created_ts": "1613203746127708",
"id": "8855426984658893616",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f6f1edae86761b39e766ec8c403a6bdb8c0bab81\"}}",
"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\": \"f6f1edae86761b39e766ec8c403a6bdb8c0bab81\", \"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-0-20gz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180550, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"f6f1edae86761b39e766ec8c403a6bdb8c0bab81\", \"got_revision_cp\": \"refs/heads/master@{#853810}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"554b7ee535b3eca3f041dc45d00de5cbd490729c\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f6f1edae86761b39e766ec8c403a6bdb8c0bab81\", \"swarm_hashes_refs/heads/master(at){#853810}_without_patch\": {\"absl_hardening_tests\": \"65a73bcc0fd22a4a75050fabf8e6fe2711e082ed\", \"accessibility_unittests\": \"30081033eb0dd4e65747bd29c62916447d1a0b7a\", \"angle_unittests\": \"e3aaa0f3d982c538f88a124d1feef1d2b110c609\", \"app_shell_unittests\": \"e641d9efe1ed06cd0ec54ee13ffdb9fd41856695\", \"aura_unittests\": \"d6055fc35f3c8f7724b5df694ccf4c4c5168d97f\", \"base_unittests\": \"28c17d0d945ebd621d162f6677aeec5d6ef69d73\", \"base_util_unittests\": \"6d40faa83f7bedb626ac6b21bf90c0342ea79297\", \"blink_common_unittests\": \"17c8897f294236c233478cc0286a7ecf1a719d39\", \"blink_fuzzer_unittests\": \"77c42dccc26f7e2400468319cf1910fbe9fc7fee\", \"blink_heap_unittests\": \"6c3975102556af98a18b57554f4744163e3aeeee\", \"blink_platform_unittests\": \"37a5a6ce67bf8ad3c754deca810469ff132f5823\", \"blink_python_tests\": \"e8a57771c000a66e6a51f3244690605a36dc48ae\", \"blink_unittests\": \"26c7c4327c8f71137fd04abce3c19487fe3f9cff\", \"blink_web_tests\": \"071c3724325192ee5dcad1baa876751f2a977de1\", \"boringssl_crypto_tests\": \"607475d494daba2aad555150c7761f5ff65aba69\", \"boringssl_ssl_tests\": \"d2f144c43bbba27e8db068bb4e0d2327d105e1f5\", \"browser_tests\": \"c308d38464a50465e93e66380ba66741bb94f5ad\", \"capture_unittests\": \"1566b20522fb8b826be8d59a0e4004d6f45e1ad7\", \"cast_unittests\": \"f2af0291e6eb46188ff73089233683872a8a06bd\", \"cc_unittests\": \"44292bf2393fcf685330a6fcffd7ad231bf96ec4\", \"chrome_app_unittests\": \"fed8c60a6c32d8a85a680d6dc45b57c01b58fe8f\", \"chromedriver_unittests\": \"9702ab082b61d9392053c0e69e5805e2f4ebf741\", \"components_browsertests\": \"737ab4d6bd7318bbaf0c82676137a502e66e59d2\", \"components_unittests\": \"baecb46eb9e5bc49bda5f7978c2065efe88079d6\", \"compositor_unittests\": \"18ed2dafd89cea4b226d50368abef238ab80535d\", \"content_browsertests\": \"ee8e68c36a8eb919e65b97290f894b82d25da402\", \"content_shell_crash_test\": \"88d74f432019a4bf11d770e1963b8fe00eba8221\", \"content_unittests\": \"acea2a8becc3ad336795d45ba93216311ddcecbe\", \"crashpad_tests\": \"cf19fa566f4ef1cfce109f2d56ae45162a0d9239\", \"cronet_tests\": \"96b33ca3a29175c9367733c8592509f5aa24f9a0\", \"cronet_unittests\": \"08596ece5d10bbfec97301e90478be1244d2fe9f\", \"crypto_unittests\": \"f3742ad614989835aea5c5d14a39ffcf24d27018\", \"dbus_unittests\": \"2bf97c05e2a645875afebdf08605e7043cf171a9\", \"device_unittests\": \"b9c040f97854650d77dadb522a59e4dc85a57107\", \"display_unittests\": \"2ce49e1283c94eb8536c028e59619d2ce9467e29\", \"events_unittests\": \"27c66a11fff06f5c1022902db217c571c8036151\", \"extensions_browsertests\": \"ae076d2571beb347be5fb71c99ddbfd72bfbe3a5\", \"extensions_unittests\": \"b9d90fa3ee71ea072f9c3ae02f697a620afca63c\", \"filesystem_service_unittests\": \"76326f8993eaf5780dace00d35775d804471a124\", \"flatbuffers_unittests\": \"a70d9e1d8a525a4da115cbe8994192708136ab4b\", \"gcm_unit_tests\": \"255e37ce3d8d1dc3f8f72e2d42aa61d3592719c1\", \"gfx_unittests\": \"e900bc3aa7c2e1c2d8ee60b481bfdc3ee6888aff\", \"gin_unittests\": \"930e910c4238ed3f1a100f457b2b274c83514fbb\", \"google_apis_unittests\": \"de4dd4ffbd35b9a183db2f26aac2fd0424997234\", \"gpu_unittests\": \"93c0d18eab9f36b59acaa0dbba843572ffe320eb\", \"grit_python_unittests\": \"6eb7a1f1dc57239cce2e1f3e8d13a9b7cd73171c\", \"gwp_asan_unittests\": \"642918c7e90ec8e3b13247c5e3c5cc3042d4636d\", \"headless_browsertests\": \"ca3c9adb16bf448d50699e408fc841afd2a2fe3e\", \"headless_unittests\": \"7f16a63dfb527b2c9a7e32dd187ac19166770cdd\", \"interactive_ui_tests\": \"1742d559f82113833bba234af606be784a9e3970\", \"ipc_tests\": \"5c8e98f5efafcc6b56750b581f3cc26e4673b12d\", \"jingle_unittests\": \"fdd578d1941362de884a4c8535935288f4acf497\", \"latency_unittests\": \"dc7762845c705f9cb85b7061108130dbf373d74d\", \"libjingle_xmpp_unittests\": \"0e4379178cb700a63cdc6a32b596340de3ecf4c7\", \"liburlpattern_unittests\": \"6fc325582505db66da3dafc745e4475464de94f4\", \"media_blink_unittests\": \"9c2da6e56e71cb56781232e0b6cb9b0a1a67df48\", \"media_unittests\": \"401108c3a774ac80780a8eec798ad1b0de9b3340\", \"message_center_unittests\": \"e408e367cb2af8a7ce4ba12fd71f75053e9ad82e\", \"metrics_python_tests\": \"39469cc996f2c5127196e44e2e0e4d6e92537245\", \"midi_unittests\": \"e937f11996bd8acfe0bbd6d9d1c0b5bdf868c87b\", \"mojo_core_unittests\": \"4c245ee6f5064a15269e1ff6f8cd38f16c526739\", \"mojo_unittests\": \"559f76d9f554457c56e695aedde6c160aa888857\", \"nacl_helper_nonsfi_unittests\": \"2370687fd6e80575cfb0ab824fc811fce98bbb34\", \"nacl_loader_unittests\": \"bc46fb63042b1a557fd97781d15502133e6c17e9\", \"native_theme_unittests\": \"56707dea27a59409af6aa00291df4e802bccac95\", \"net_unittests\": \"5f248863eb19c47637708df0f2fa90d6519006ba\", \"openscreen_unittests\": \"63b948ab26c5d0d3b4370751df981f4eb42204b6\", \"pdf_unittests\": \"91c296bddb8ca588c88b04f0a7266e63f5091727\", \"perfetto_unittests\": \"72745347315476a4a053a9d33aa1748abf12da8f\", \"ppapi_unittests\": \"63b2357b76579267a459171e5f2b19da6d6d5059\", \"printing_unittests\": \"ba026d57babf38588cba6d18f6bbb438cc98cf06\", \"remoting_unittests\": \"3de28c8335d9818afd1b7e82d151ec3ef3705b49\", \"sandbox_linux_unittests\": \"55ca9087374205eb9b2a174e1204588e4cc5b26f\", \"service_manager_unittests\": \"5639fdc33308fdb0f7df67bf7e254358c9fea6fe\", \"services_unittests\": \"ec4688c9c92522f04e58ba141ee340e093f00d45\", \"shell_dialogs_unittests\": \"5b1b52878cedc51d493cc2c97584e46006cbfe32\", \"skia_unittests\": \"5dc815a41ce5504edc8209b4ecb8b371a1434799\", \"snapshot_unittests\": \"d7477ff52e45ef836e89424eeec216b2bd2647a0\", \"sql_unittests\": \"aa940d5ba0fc5c15c963566a48147acc9c5940c4\", \"storage_unittests\": \"c8fdead3b8bd0460ceae85afb9832b5f333d59c9\", \"sync_integration_tests\": \"5b6187ec6fdc8fffbfeb5a9a4c6ec29a07258b60\", \"telemetry_gpu_unittests\": \"fc28eb1a59fc86611f3935953b54104193056f25\", \"telemetry_perf_unittests\": \"a4ca39084178b9101f802880746af41179527b61\", \"telemetry_unittests\": \"d8996646f424d95faa1d48a309b7594ca1a613a3\", \"traffic_annotation_auditor_unittests\": \"09a1c91bbf4b8cac209b3c2e9b2aba884eeef674\", \"ui_base_unittests\": \"df82cb358faea597a7e3de003b148a2795064a67\", \"ui_touch_selection_unittests\": \"be1daeb533fd3770c62ad48c2585e1461154e248\", \"unit_tests\": \"3cc62bbf8dcddaefe93f4655111ea7eaa90d5b57\", \"url_unittests\": \"badf74ec354bc32e554dc0efb999ffe9a8fb7f0e\", \"views_perftests\": \"f39a38291983b5cb8a33c2fe72d5832a132e8da4\", \"views_unittests\": \"d0c17a6604b3378ecc9414692c58b396cefc3407\", \"viz_unittests\": \"b4009d6c04de9596a5f4e8a3bb970385aa1312c0\", \"vr_common_unittests\": \"f19958282d95185d4fee15b1805e8905d03b1ccd\", \"vr_pixeltests\": \"44e33b4faf3136b42e302c937c84cf2f2316117f\", \"webdriver_wpt_tests\": \"704cb18f6e0e03f4b99e087e94e3e1d5c34783ce\", \"weblayer_browsertests\": \"8a498a3152098bc7270362c4078a3f738ee2a526\", \"weblayer_unittests\": \"c04a1d808d7c62b098389a67c91f8138c656d53d\", \"wm_unittests\": \"79c290353fddf3221741cc2fecc6f277bc00dc89\", \"wtf_unittests\": \"f60c4a9eaf5422eb78b2447dd5b0d23b7acbb02e\", \"x11_unittests\": \"c693873f4bc9e06a89ed2ecb389a1cd3d5c5e67b\", \"xr_browser_tests\": \"ee771c35437af44aac38fa6e23393c3065bce152\", \"zlib_unittests\": \"642c7f3186f9ce00fbccbffcc06620324832ed43\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_620847ba863b7b859d365f855d10aa27bab23d13b665ad3a30c50048a11ad6c4_v2\", \"builder_8f7e40299f74ff9d94767563834f98f87bf45cac7401cd036aab5fd865cb3b58_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_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-0-20gz\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5690-40331dd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613205721617691",
"status": "COMPLETED",
"status_changed_ts": "1613210378305495",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180550",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f6f1edae86761b39e766ec8c403a6bdb8c0bab81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f6f1edae86761b39e766ec8c403a6bdb8c0bab81",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020857046739787408",
"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/8855426984658893616/+/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:51b3413aee802810",
"user_agent:luci-scheduler"
],
"updated_ts": "1613210378311555",
"url": "https://ci.chromium.org/b/8855426984658893616",
"utcnow_ts": "1613210378674187"
}
}
[09:59:38.684] Invocation finished in 1h50m33.924984515s with status SUCCEEDED