[05:46:10.811] New invocation is queued and will start shortly
[05:46:12.225] Starting the invocation (attempt 1)
[05:46:12.302] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:46:12.302] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:46:12.302] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031375285297045600",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"300a9a4c5c6ffe98233f57b2745c10c9b63a3635\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9031375285297045600",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/300a9a4c5c6ffe98233f57b2745c10c9b63a3635",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/300a9a4c5c6ffe98233f57b2745c10c9b63a3635",
"gitiles_ref:refs/heads/master"
]
}
[05:46:13.491] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603172772460562",
"id": "8865945222903554528",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"300a9a4c5c6ffe98233f57b2745c10c9b63a3635\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603172773324808",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/29329",
"builder:Deterministic Linux",
"buildset:commit/git/300a9a4c5c6ffe98233f57b2745c10c9b63a3635",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/300a9a4c5c6ffe98233f57b2745c10c9b63a3635",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031375285297045600",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865945222903554528/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1603172773324934",
"url": "https://ci.chromium.org/b/8865945222903554528",
"utcnow_ts": "1603172773482671"
}
}
[05:46:13.491] Task URL: https://ci.chromium.org/b/8865945222903554528
[05:46:13.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:2:0) after 1m0s
[05:46:17.244] Received PubSub notification, asking Buildbucket for the build status
[05:46:17.398] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:13.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:2:0)
[05:47:13.522] Timer tick, asking Buildbucket for the build status
[05:47:14.076] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:14.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:4:0) after 1m0s
[05:48:14.132] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:4:0)
[05:48:14.132] Timer tick, asking Buildbucket for the build status
[05:48:14.188] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:14.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:5:0) after 1m0s
[05:49:14.227] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:5:0)
[05:49:14.227] Timer tick, asking Buildbucket for the build status
[05:49:14.378] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:14.378] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:6:0) after 1m0s
[05:50:14.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:6:0)
[05:50:14.444] Timer tick, asking Buildbucket for the build status
[05:50:14.698] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:14.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:7:0) after 1m0s
[05:51:14.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:7:0)
[05:51:14.784] Timer tick, asking Buildbucket for the build status
[05:51:15.176] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:15.176] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:8:0) after 1m0s
[05:52:15.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:8:0)
[05:52:15.229] Timer tick, asking Buildbucket for the build status
[05:52:15.327] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:15.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:9:0) after 1m0s
[05:53:15.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:9:0)
[05:53:15.338] Timer tick, asking Buildbucket for the build status
[05:53:15.402] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:15.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:10:0) after 1m0s
[05:54:15.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:10:0)
[05:54:15.441] Timer tick, asking Buildbucket for the build status
[05:54:15.520] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:15.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:11:0) after 1m0s
[05:55:15.585] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:11:0)
[05:55:15.585] Timer tick, asking Buildbucket for the build status
[05:55:15.683] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:15.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:12:0) after 1m0s
[05:56:15.691] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:12:0)
[05:56:15.691] Timer tick, asking Buildbucket for the build status
[05:56:17.285] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:17.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:13:0) after 1m0s
[05:57:17.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:13:0)
[05:57:17.338] Timer tick, asking Buildbucket for the build status
[05:57:17.499] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:17.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:14:0) after 1m0s
[05:58:17.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:14:0)
[05:58:17.630] Timer tick, asking Buildbucket for the build status
[05:58:17.725] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:17.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:15:0) after 1m0s
[05:59:17.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:15:0)
[05:59:17.821] Timer tick, asking Buildbucket for the build status
[05:59:17.882] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:17.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:16:0) after 1m0s
[06:00:17.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:16:0)
[06:00:17.908] Timer tick, asking Buildbucket for the build status
[06:00:17.968] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:17.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:17:0) after 1m0s
[06:01:23.565] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:17:0)
[06:01:23.565] Timer tick, asking Buildbucket for the build status
[06:01:23.679] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:23.679] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:18:0) after 1m0s
[06:02:23.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:18:0)
[06:02:23.706] Timer tick, asking Buildbucket for the build status
[06:02:23.773] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:23.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:19:0) after 1m0s
[06:03:23.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:19:0)
[06:03:23.822] Timer tick, asking Buildbucket for the build status
[06:03:23.883] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:23.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:20:0) after 1m0s
[06:04:23.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:20:0)
[06:04:23.901] Timer tick, asking Buildbucket for the build status
[06:04:23.958] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:23.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:21:0) after 1m0s
[06:05:23.976] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:21:0)
[06:05:23.976] Timer tick, asking Buildbucket for the build status
[06:05:24.181] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:24.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:22:0) after 1m0s
[06:06:24.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:22:0)
[06:06:24.230] Timer tick, asking Buildbucket for the build status
[06:06:24.490] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:24.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:23:0) after 1m0s
[06:07:24.499] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:23:0)
[06:07:24.499] Timer tick, asking Buildbucket for the build status
[06:07:24.566] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:24.566] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:24:0) after 1m0s
[06:08:24.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:24:0)
[06:08:24.665] Timer tick, asking Buildbucket for the build status
[06:08:24.793] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:24.793] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:25:0) after 1m0s
[06:09:24.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:25:0)
[06:09:24.788] Timer tick, asking Buildbucket for the build status
[06:09:25.218] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:25.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:26:0) after 1m0s
[06:10:25.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:26:0)
[06:10:25.271] Timer tick, asking Buildbucket for the build status
[06:10:25.580] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:25.580] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:27:0) after 1m0s
[06:11:25.655] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:27:0)
[06:11:25.655] Timer tick, asking Buildbucket for the build status
[06:11:25.772] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:25.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:28:0) after 1m0s
[06:12:25.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:28:0)
[06:12:25.827] Timer tick, asking Buildbucket for the build status
[06:12:25.885] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:25.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:29:0) after 1m0s
[06:13:25.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:29:0)
[06:13:25.908] Timer tick, asking Buildbucket for the build status
[06:13:25.969] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:25.969] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:30:0) after 1m0s
[06:14:25.998] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:30:0)
[06:14:25.998] Timer tick, asking Buildbucket for the build status
[06:14:26.108] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:26.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:31:0) after 1m0s
[06:15:26.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:31:0)
[06:15:26.155] Timer tick, asking Buildbucket for the build status
[06:15:26.284] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:26.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:32:0) after 1m0s
[06:16:26.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:32:0)
[06:16:26.312] Timer tick, asking Buildbucket for the build status
[06:16:26.415] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:26.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:33:0) after 1m0s
[06:17:26.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:33:0)
[06:17:26.464] Timer tick, asking Buildbucket for the build status
[06:17:26.543] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:26.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:34:0) after 1m0s
[06:18:26.587] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:34:0)
[06:18:26.588] Timer tick, asking Buildbucket for the build status
[06:18:26.682] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:26.682] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:35:0) after 1m0s
[06:19:26.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:35:0)
[06:19:26.715] Timer tick, asking Buildbucket for the build status
[06:19:26.778] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:26.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:36:0) after 1m0s
[06:20:26.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:36:0)
[06:20:26.825] Timer tick, asking Buildbucket for the build status
[06:20:27.095] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:27.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:37:0) after 1m0s
[06:21:27.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:37:0)
[06:21:27.161] Timer tick, asking Buildbucket for the build status
[06:21:27.303] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:27.303] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:38:0) after 1m0s
[06:22:27.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:38:0)
[06:22:27.326] Timer tick, asking Buildbucket for the build status
[06:22:27.430] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:27.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:39:0) after 1m0s
[06:23:27.425] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:39:0)
[06:23:27.425] Timer tick, asking Buildbucket for the build status
[06:23:27.507] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:27.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:40:0) after 1m0s
[06:24:27.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:40:0)
[06:24:27.621] Timer tick, asking Buildbucket for the build status
[06:24:27.687] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:27.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:41:0) after 1m0s
[06:25:27.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:41:0)
[06:25:27.741] Timer tick, asking Buildbucket for the build status
[06:25:27.808] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:27.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:42:0) after 1m0s
[06:26:27.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:42:0)
[06:26:27.798] Timer tick, asking Buildbucket for the build status
[06:26:27.924] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:27.924] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:43:0) after 1m0s
[06:27:27.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:43:0)
[06:27:27.948] Timer tick, asking Buildbucket for the build status
[06:27:28.007] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:28.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:44:0) after 1m0s
[06:28:28.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:44:0)
[06:28:28.086] Timer tick, asking Buildbucket for the build status
[06:28:28.198] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:28.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:45:0) after 1m0s
[06:29:28.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:45:0)
[06:29:28.221] Timer tick, asking Buildbucket for the build status
[06:29:28.513] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:28.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:46:0) after 1m0s
[06:30:28.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:46:0)
[06:30:28.540] Timer tick, asking Buildbucket for the build status
[06:30:28.736] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:28.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:47:0) after 1m0s
[06:31:28.800] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:47:0)
[06:31:28.800] Timer tick, asking Buildbucket for the build status
[06:31:29.186] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:29.186] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:48:0) after 1m0s
[06:32:29.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:48:0)
[06:32:29.201] Timer tick, asking Buildbucket for the build status
[06:32:29.309] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:29.309] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:49:0) after 1m0s
[06:33:29.385] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:49:0)
[06:33:29.385] Timer tick, asking Buildbucket for the build status
[06:33:29.503] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:29.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:50:0) after 1m0s
[06:34:29.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:50:0)
[06:34:29.563] Timer tick, asking Buildbucket for the build status
[06:34:29.944] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:29.944] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:51:0) after 1m0s
[06:35:29.981] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:51:0)
[06:35:29.981] Timer tick, asking Buildbucket for the build status
[06:35:30.043] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:30.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:52:0) after 1m0s
[06:36:30.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:52:0)
[06:36:30.066] Timer tick, asking Buildbucket for the build status
[06:36:30.173] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:30.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:53:0) after 1m0s
[06:37:30.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:53:0)
[06:37:30.201] Timer tick, asking Buildbucket for the build status
[06:37:30.262] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:30.262] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:54:0) after 1m0s
[06:38:30.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:54:0)
[06:38:30.378] Timer tick, asking Buildbucket for the build status
[06:38:30.472] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:30.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:55:0) after 1m0s
[06:39:30.559] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:55:0)
[06:39:30.559] Timer tick, asking Buildbucket for the build status
[06:39:30.637] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:30.637] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:56:0) after 1m0s
[06:40:30.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:56:0)
[06:40:30.662] Timer tick, asking Buildbucket for the build status
[06:40:30.874] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:30.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:57:0) after 1m0s
[06:41:30.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:57:0)
[06:41:30.894] Timer tick, asking Buildbucket for the build status
[06:41:31.001] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:31.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:58:0) after 1m0s
[06:42:31.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:58:0)
[06:42:31.037] Timer tick, asking Buildbucket for the build status
[06:42:31.103] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:31.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:59:0) after 1m0s
[06:43:31.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:59:0)
[06:43:31.192] Timer tick, asking Buildbucket for the build status
[06:43:31.442] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:31.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:60:0) after 1m0s
[06:44:31.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:60:0)
[06:44:31.512] Timer tick, asking Buildbucket for the build status
[06:44:31.579] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:31.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:61:0) after 1m0s
[06:45:31.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:61:0)
[06:45:31.729] Timer tick, asking Buildbucket for the build status
[06:45:31.874] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:31.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:62:0) after 1m0s
[06:46:31.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:62:0)
[06:46:31.929] Timer tick, asking Buildbucket for the build status
[06:46:32.315] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:32.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:63:0) after 1m0s
[06:47:32.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:63:0)
[06:47:32.394] Timer tick, asking Buildbucket for the build status
[06:47:32.498] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:32.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:64:0) after 1m0s
[06:48:32.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:64:0)
[06:48:32.489] Timer tick, asking Buildbucket for the build status
[06:48:32.601] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:32.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:65:0) after 1m0s
[06:49:32.633] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:65:0)
[06:49:32.633] Timer tick, asking Buildbucket for the build status
[06:49:32.699] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:32.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:66:0) after 1m0s
[06:50:32.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:66:0)
[06:50:32.803] Timer tick, asking Buildbucket for the build status
[06:50:32.862] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:32.862] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:67:0) after 1m0s
[06:51:32.941] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:67:0)
[06:51:32.941] Timer tick, asking Buildbucket for the build status
[06:51:33.053] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:33.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:68:0) after 1m0s
[06:52:33.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:68:0)
[06:52:33.166] Timer tick, asking Buildbucket for the build status
[06:52:33.481] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:33.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:69:0) after 1m0s
[06:53:33.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:69:0)
[06:53:33.556] Timer tick, asking Buildbucket for the build status
[06:53:33.720] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:33.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:70:0) after 1m0s
[06:54:33.746] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:70:0)
[06:54:33.746] Timer tick, asking Buildbucket for the build status
[06:54:34.025] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:34.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:71:0) after 1m0s
[06:55:34.053] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:71:0)
[06:55:34.053] Timer tick, asking Buildbucket for the build status
[06:55:34.201] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:34.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:72:0) after 1m0s
[06:56:34.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:72:0)
[06:56:34.269] Timer tick, asking Buildbucket for the build status
[06:56:34.471] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:34.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:73:0) after 1m0s
[06:57:34.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:73:0)
[06:57:34.515] Timer tick, asking Buildbucket for the build status
[06:57:34.587] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:34.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:74:0) after 1m0s
[06:58:34.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:74:0)
[06:58:34.666] Timer tick, asking Buildbucket for the build status
[06:58:34.727] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:34.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:75:0) after 1m0s
[06:59:34.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:75:0)
[06:59:34.827] Timer tick, asking Buildbucket for the build status
[06:59:34.892] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:34.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:76:0) after 1m0s
[07:00:34.960] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:76:0)
[07:00:34.960] Timer tick, asking Buildbucket for the build status
[07:00:35.035] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:35.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:77:0) after 1m0s
[07:01:35.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:77:0)
[07:01:35.115] Timer tick, asking Buildbucket for the build status
[07:01:35.283] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:35.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:78:0) after 1m0s
[07:02:35.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:78:0)
[07:02:35.337] Timer tick, asking Buildbucket for the build status
[07:02:35.607] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:35.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:79:0) after 1m0s
[07:03:35.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:79:0)
[07:03:35.679] Timer tick, asking Buildbucket for the build status
[07:03:35.770] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:35.770] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:80:0) after 1m0s
[07:04:35.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:80:0)
[07:04:35.830] Timer tick, asking Buildbucket for the build status
[07:04:37.821] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:37.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:81:0) after 1m0s
[07:05:37.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:81:0)
[07:05:37.832] Timer tick, asking Buildbucket for the build status
[07:05:37.920] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:37.920] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:82:0) after 1m0s
[07:06:37.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:82:0)
[07:06:37.977] Timer tick, asking Buildbucket for the build status
[07:06:38.083] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:38.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:83:0) after 1m0s
[07:07:38.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:83:0)
[07:07:38.103] Timer tick, asking Buildbucket for the build status
[07:07:38.222] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:38.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:84:0) after 1m0s
[07:08:38.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:84:0)
[07:08:38.233] Timer tick, asking Buildbucket for the build status
[07:08:38.296] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:38.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:85:0) after 1m0s
[07:09:38.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:85:0)
[07:09:38.326] Timer tick, asking Buildbucket for the build status
[07:09:38.651] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:38.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:86:0) after 1m0s
[07:10:38.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:86:0)
[07:10:38.657] Timer tick, asking Buildbucket for the build status
[07:10:38.742] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:38.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:87:0) after 1m0s
[07:11:38.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:87:0)
[07:11:38.777] Timer tick, asking Buildbucket for the build status
[07:11:38.879] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:38.879] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:88:0) after 1m0s
[07:12:38.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:88:0)
[07:12:38.918] Timer tick, asking Buildbucket for the build status
[07:12:38.977] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:38.977] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:89:0) after 1m0s
[07:13:39.110] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:89:0)
[07:13:39.110] Timer tick, asking Buildbucket for the build status
[07:13:39.192] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:39.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:90:0) after 1m0s
[07:14:39.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:90:0)
[07:14:39.282] Timer tick, asking Buildbucket for the build status
[07:14:39.674] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:39.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:91:0) after 1m0s
[07:15:39.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:91:0)
[07:15:39.751] Timer tick, asking Buildbucket for the build status
[07:15:39.886] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:39.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:92:0) after 1m0s
[07:16:39.998] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:92:0)
[07:16:39.998] Timer tick, asking Buildbucket for the build status
[07:16:40.139] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:40.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:93:0) after 1m0s
[07:17:40.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:93:0)
[07:17:40.154] Timer tick, asking Buildbucket for the build status
[07:17:40.211] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:40.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:94:0) after 1m0s
[07:18:40.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:94:0)
[07:18:40.230] Timer tick, asking Buildbucket for the build status
[07:18:40.292] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:40.292] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:95:0) after 1m0s
[07:19:40.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:95:0)
[07:19:40.311] Timer tick, asking Buildbucket for the build status
[07:19:40.689] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:40.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:96:0) after 1m0s
[07:20:40.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:96:0)
[07:20:40.726] Timer tick, asking Buildbucket for the build status
[07:20:40.799] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:40.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:97:0) after 1m0s
[07:21:40.840] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:97:0)
[07:21:40.840] Timer tick, asking Buildbucket for the build status
[07:21:41.361] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:41.361] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:98:0) after 1m0s
[07:22:41.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:98:0)
[07:22:41.342] Timer tick, asking Buildbucket for the build status
[07:22:41.407] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:41.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:99:0) after 1m0s
[07:23:41.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:99:0)
[07:23:41.488] Timer tick, asking Buildbucket for the build status
[07:23:41.602] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:41.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:100:0) after 1m0s
[07:24:41.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:100:0)
[07:24:41.663] Timer tick, asking Buildbucket for the build status
[07:24:41.993] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:41.993] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:101:0) after 1m0s
[07:25:42.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:101:0)
[07:25:42.076] Timer tick, asking Buildbucket for the build status
[07:25:42.136] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:42.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:102:0) after 1m0s
[07:26:42.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:102:0)
[07:26:42.200] Timer tick, asking Buildbucket for the build status
[07:26:42.419] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:42.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:103:0) after 1m0s
[07:27:42.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:103:0)
[07:27:42.457] Timer tick, asking Buildbucket for the build status
[07:27:42.681] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:42.681] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:104:0) after 1m0s
[07:28:42.721] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:104:0)
[07:28:42.721] Timer tick, asking Buildbucket for the build status
[07:28:42.814] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:42.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:105:0) after 1m0s
[07:29:42.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:105:0)
[07:29:42.917] Timer tick, asking Buildbucket for the build status
[07:29:43.117] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:43.117] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:106:0) after 1m0s
[07:30:43.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:106:0)
[07:30:43.135] Timer tick, asking Buildbucket for the build status
[07:30:43.308] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:43.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:107:0) after 1m0s
[07:31:43.387] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:107:0)
[07:31:43.387] Timer tick, asking Buildbucket for the build status
[07:31:43.507] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:43.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:108:0) after 1m0s
[07:32:43.624] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:108:0)
[07:32:43.624] Timer tick, asking Buildbucket for the build status
[07:32:43.716] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:43.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:109:0) after 1m0s
[07:33:43.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:109:0)
[07:33:43.765] Timer tick, asking Buildbucket for the build status
[07:33:43.839] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:43.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:110:0) after 1m0s
[07:34:43.865] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:110:0)
[07:34:43.866] Timer tick, asking Buildbucket for the build status
[07:34:43.931] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:43.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:111:0) after 1m0s
[07:35:43.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:111:0)
[07:35:43.968] Timer tick, asking Buildbucket for the build status
[07:35:44.048] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:44.048] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:112:0) after 1m0s
[07:36:44.081] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:112:0)
[07:36:44.081] Timer tick, asking Buildbucket for the build status
[07:36:44.415] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:44.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:113:0) after 1m0s
[07:37:44.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:113:0)
[07:37:44.444] Timer tick, asking Buildbucket for the build status
[07:37:44.523] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:44.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:114:0) after 1m0s
[07:38:44.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:114:0)
[07:38:44.527] Timer tick, asking Buildbucket for the build status
[07:38:45.013] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:45.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:115:0) after 1m0s
[07:39:45.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:115:0)
[07:39:45.040] Timer tick, asking Buildbucket for the build status
[07:39:45.101] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:45.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:116:0) after 1m0s
[07:40:45.175] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:116:0)
[07:40:45.175] Timer tick, asking Buildbucket for the build status
[07:40:45.273] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:45.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:117:0) after 1m0s
[07:41:45.316] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:117:0)
[07:41:45.316] Timer tick, asking Buildbucket for the build status
[07:41:45.806] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:45.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:118:0) after 1m0s
[07:42:45.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:118:0)
[07:42:45.855] Timer tick, asking Buildbucket for the build status
[07:42:45.981] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:45.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:119:0) after 1m0s
[07:43:46.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:119:0)
[07:43:46.037] Timer tick, asking Buildbucket for the build status
[07:43:46.437] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:46.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:120:0) after 1m0s
[07:44:46.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:120:0)
[07:44:46.455] Timer tick, asking Buildbucket for the build status
[07:44:46.523] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:46.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:121:0) after 1m0s
[07:45:46.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:121:0)
[07:45:46.595] Timer tick, asking Buildbucket for the build status
[07:45:46.672] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:46.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:122:0) after 1m0s
[07:46:46.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:122:0)
[07:46:46.697] Timer tick, asking Buildbucket for the build status
[07:46:46.797] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:46.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:123:0) after 1m0s
[07:47:46.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:123:0)
[07:47:46.871] Timer tick, asking Buildbucket for the build status
[07:47:47.296] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:47.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:124:0) after 1m0s
[07:48:47.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:124:0)
[07:48:47.402] Timer tick, asking Buildbucket for the build status
[07:48:47.469] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:47.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:125:0) after 1m0s
[07:49:47.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:125:0)
[07:49:47.535] Timer tick, asking Buildbucket for the build status
[07:49:47.732] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:47.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:126:0) after 1m0s
[07:50:47.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:126:0)
[07:50:47.802] Timer tick, asking Buildbucket for the build status
[07:50:47.862] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:47.862] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:127:0) after 1m0s
[07:51:47.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:127:0)
[07:51:47.886] Timer tick, asking Buildbucket for the build status
[07:51:47.986] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:47.986] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:128:0) after 1m0s
[07:52:48.010] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:128:0)
[07:52:48.010] Timer tick, asking Buildbucket for the build status
[07:52:48.067] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:48.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:129:0) after 1m0s
[07:53:48.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:129:0)
[07:53:48.135] Timer tick, asking Buildbucket for the build status
[07:53:48.316] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:48.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:130:0) after 1m0s
[07:54:48.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:130:0)
[07:54:48.374] Timer tick, asking Buildbucket for the build status
[07:54:48.478] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:48.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:131:0) after 1m0s
[07:55:48.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:131:0)
[07:55:48.517] Timer tick, asking Buildbucket for the build status
[07:55:48.576] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:48.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:132:0) after 1m0s
[07:56:48.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:132:0)
[07:56:48.606] Timer tick, asking Buildbucket for the build status
[07:56:48.712] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:48.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:133:0) after 1m0s
[07:57:48.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:133:0)
[07:57:48.741] Timer tick, asking Buildbucket for the build status
[07:57:48.816] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:48.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:134:0) after 1m0s
[07:58:48.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:134:0)
[07:58:48.862] Timer tick, asking Buildbucket for the build status
[07:58:49.043] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:49.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:135:0) after 1m0s
[07:59:49.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:135:0)
[07:59:49.078] Timer tick, asking Buildbucket for the build status
[07:59:49.136] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:49.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:136:0) after 1m0s
[08:00:49.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:136:0)
[08:00:49.207] Timer tick, asking Buildbucket for the build status
[08:00:49.278] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:49.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:137:0) after 1m0s
[08:01:49.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:137:0)
[08:01:49.346] Timer tick, asking Buildbucket for the build status
[08:01:49.447] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:49.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:138:0) after 1m0s
[08:02:49.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:138:0)
[08:02:49.638] Timer tick, asking Buildbucket for the build status
[08:02:49.721] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:49.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:139:0) after 1m0s
[08:03:49.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:139:0)
[08:03:49.754] Timer tick, asking Buildbucket for the build status
[08:03:49.933] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:49.933] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:140:0) after 1m0s
[08:04:49.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:140:0)
[08:04:49.963] Timer tick, asking Buildbucket for the build status
[08:04:50.096] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:50.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:141:0) after 1m0s
[08:05:50.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:141:0)
[08:05:50.127] Timer tick, asking Buildbucket for the build status
[08:05:50.228] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:50.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:142:0) after 1m0s
[08:06:50.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:142:0)
[08:06:50.267] Timer tick, asking Buildbucket for the build status
[08:06:50.458] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:50.458] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:143:0) after 1m0s
[08:07:50.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:143:0)
[08:07:50.491] Timer tick, asking Buildbucket for the build status
[08:07:50.545] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:50.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:144:0) after 1m0s
[08:08:50.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:144:0)
[08:08:50.569] Timer tick, asking Buildbucket for the build status
[08:08:50.639] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:50.639] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:145:0) after 1m0s
[08:09:50.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:145:0)
[08:09:50.664] Timer tick, asking Buildbucket for the build status
[08:09:50.750] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:50.750] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:146:0) after 1m0s
[08:10:50.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:146:0)
[08:10:50.751] Timer tick, asking Buildbucket for the build status
[08:10:50.808] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:50.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:147:0) after 1m0s
[08:11:50.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:147:0)
[08:11:50.937] Timer tick, asking Buildbucket for the build status
[08:11:51.068] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:51.068] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:148:0) after 1m0s
[08:12:51.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:148:0)
[08:12:51.094] Timer tick, asking Buildbucket for the build status
[08:12:51.421] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:51.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:149:0) after 1m0s
[08:13:51.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:149:0)
[08:13:51.473] Timer tick, asking Buildbucket for the build status
[08:13:51.764] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:51.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:150:0) after 1m0s
[08:14:51.796] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:150:0)
[08:14:51.796] Timer tick, asking Buildbucket for the build status
[08:14:52.002] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:52.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:151:0) after 1m0s
[08:15:51.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:151:0)
[08:15:51.993] Timer tick, asking Buildbucket for the build status
[08:15:52.218] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:52.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:152:0) after 1m0s
[08:16:52.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:152:0)
[08:16:52.248] Timer tick, asking Buildbucket for the build status
[08:16:52.352] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:52.352] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:153:0) after 1m0s
[08:17:52.380] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:153:0)
[08:17:52.380] Timer tick, asking Buildbucket for the build status
[08:17:52.438] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:52.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:154:0) after 1m0s
[08:18:52.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:154:0)
[08:18:52.505] Timer tick, asking Buildbucket for the build status
[08:18:52.634] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:52.635] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:155:0) after 1m0s
[08:19:52.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:155:0)
[08:19:52.762] Timer tick, asking Buildbucket for the build status
[08:19:52.839] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:52.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:156:0) after 1m0s
[08:20:52.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:156:0)
[08:20:52.866] Timer tick, asking Buildbucket for the build status
[08:20:52.931] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:52.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:157:0) after 1m0s
[08:21:52.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:157:0)
[08:21:52.962] Timer tick, asking Buildbucket for the build status
[08:21:53.134] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:53.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:158:0) after 1m0s
[08:22:53.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:158:0)
[08:22:53.161] Timer tick, asking Buildbucket for the build status
[08:22:53.316] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:53.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:159:0) after 1m0s
[08:23:53.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:159:0)
[08:23:53.368] Timer tick, asking Buildbucket for the build status
[08:23:53.435] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:53.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:160:0) after 1m0s
[08:24:53.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:160:0)
[08:24:53.477] Timer tick, asking Buildbucket for the build status
[08:24:53.546] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:53.546] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:161:0) after 1m0s
[08:25:53.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:161:0)
[08:25:53.603] Timer tick, asking Buildbucket for the build status
[08:25:53.746] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:53.746] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:162:0) after 1m0s
[08:26:53.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:162:0)
[08:26:53.777] Timer tick, asking Buildbucket for the build status
[08:26:53.910] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:53.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:163:0) after 1m0s
[08:27:54.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:163:0)
[08:27:54.031] Timer tick, asking Buildbucket for the build status
[08:27:54.191] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:54.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:164:0) after 1m0s
[08:28:54.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:164:0)
[08:28:54.256] Timer tick, asking Buildbucket for the build status
[08:28:54.428] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:54.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:165:0) after 1m0s
[08:29:54.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:165:0)
[08:29:54.535] Timer tick, asking Buildbucket for the build status
[08:29:54.600] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:54.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:166:0) after 1m0s
[08:30:54.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:166:0)
[08:30:54.724] Timer tick, asking Buildbucket for the build status
[08:30:54.801] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:54.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:167:0) after 1m0s
[08:31:54.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:167:0)
[08:31:54.819] Timer tick, asking Buildbucket for the build status
[08:31:55.000] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:55.000] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:168:0) after 1m0s
[08:32:55.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:168:0)
[08:32:55.138] Timer tick, asking Buildbucket for the build status
[08:32:55.201] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:55.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:169:0) after 1m0s
[08:33:55.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:169:0)
[08:33:55.312] Timer tick, asking Buildbucket for the build status
[08:33:55.386] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:55.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:170:0) after 1m0s
[08:34:55.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:170:0)
[08:34:55.573] Timer tick, asking Buildbucket for the build status
[08:34:55.715] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:55.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:171:0) after 1m0s
[08:35:55.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:171:0)
[08:35:55.722] Timer tick, asking Buildbucket for the build status
[08:35:55.837] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:55.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:172:0) after 1m0s
[08:36:55.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:172:0)
[08:36:55.906] Timer tick, asking Buildbucket for the build status
[08:36:56.378] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:56.378] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:173:0) after 1m0s
[08:37:56.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:173:0)
[08:37:56.392] Timer tick, asking Buildbucket for the build status
[08:37:56.602] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:56.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:174:0) after 1m0s
[08:38:56.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:174:0)
[08:38:56.671] Timer tick, asking Buildbucket for the build status
[08:38:56.813] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:56.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:175:0) after 1m0s
[08:39:56.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:175:0)
[08:39:56.999] Timer tick, asking Buildbucket for the build status
[08:39:57.281] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:57.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:176:0) after 1m0s
[08:40:57.400] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:176:0)
[08:40:57.400] Timer tick, asking Buildbucket for the build status
[08:40:57.602] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:57.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:177:0) after 1m0s
[08:41:57.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:177:0)
[08:41:57.629] Timer tick, asking Buildbucket for the build status
[08:41:57.721] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:57.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:178:0) after 1m0s
[08:42:57.772] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:178:0)
[08:42:57.772] Timer tick, asking Buildbucket for the build status
[08:42:58.102] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:58.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:179:0) after 1m0s
[08:43:58.214] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:179:0)
[08:43:58.214] Timer tick, asking Buildbucket for the build status
[08:43:58.268] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:58.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:180:0) after 1m0s
[08:44:58.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:180:0)
[08:44:58.383] Timer tick, asking Buildbucket for the build status
[08:44:58.526] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:58.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:181:0) after 1m0s
[08:45:58.594] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:181:0)
[08:45:58.594] Timer tick, asking Buildbucket for the build status
[08:45:58.688] Build 8865945222903554528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:58.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9031375285297045600:182:0) after 1m0s
[08:46:12.678] Received PubSub notification, asking Buildbucket for the build status
[08:46:12.742] Build 8865945222903554528: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:46:12.742] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603183572084160",
"created_by": "project:chromium",
"created_ts": "1603172772460562",
"failure_reason": "BUILD_FAILURE",
"id": "8865945222903554528",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"300a9a4c5c6ffe98233f57b2745c10c9b63a3635\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"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/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-99-9q74\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 29329, \"got_angle_revision\": \"babce049d02e2d4904f954c3e6b66a40f4f9467c\", \"got_dawn_revision\": \"c4593127cbdd382c18afea59b242b8040db5e4ce\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"300a9a4c5c6ffe98233f57b2745c10c9b63a3635\", \"got_revision_cp\": \"refs/heads/master@{#818795}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"38f7cc8c61e22cd8efefa458778d28aa318ddeec\", \"got_v8_revision_cp\": \"refs/heads/8.8.133@{#1}\", \"got_webrtc_revision\": \"d273ed0320fcac7ffd6a083f4fb7871189e3446c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32446}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"300a9a4c5c6ffe98233f57b2745c10c9b63a3635\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_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-99-9q74\"], \"image\": [\"chrome-xenial-20101600-2d400e1627f\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"Step('compare_build_artifacts') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603172776346361",
"status": "COMPLETED",
"status_changed_ts": "1603172776890117",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/29329",
"builder:Deterministic Linux",
"buildset:commit/git/300a9a4c5c6ffe98233f57b2745c10c9b63a3635",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/300a9a4c5c6ffe98233f57b2745c10c9b63a3635",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031375285297045600",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865945222903554528/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4f5d5cb86d48cb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603183572157250",
"url": "https://ci.chromium.org/b/8865945222903554528",
"utcnow_ts": "1603183572734827"
}
}
[08:46:12.742] Invocation finished in 3h0m1.948092936s with status FAILED