[16:59:07.121] New invocation is queued and will start shortly
[16:59:08.211] Starting the invocation (attempt 1)
[16:59:08.251] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:59:08.251] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:59:08.251] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9075634864242086208",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"de87ca945cfee1a8cf2471e9fffc2597b143e20c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9075634864242086208",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/de87ca945cfee1a8cf2471e9fffc2597b143e20c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/de87ca945cfee1a8cf2471e9fffc2597b143e20c",
"gitiles_ref:refs/heads/master"
]
}
[16:59:09.678] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1560963548831613",
"id": "8910204801778895760",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"de87ca945cfee1a8cf2471e9fffc2597b143e20c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560963549494453",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23791",
"builder:Deterministic Linux",
"buildset:commit/git/de87ca945cfee1a8cf2471e9fffc2597b143e20c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/de87ca945cfee1a8cf2471e9fffc2597b143e20c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075634864242086208",
"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/8910204801778895760/+/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": "1560963549494725",
"url": "https://ci.chromium.org/b/8910204801778895760",
"utcnow_ts": "1560963549670573"
}
}
[16:59:09.678] Task URL: https://ci.chromium.org/b/8910204801778895760
[16:59:09.678] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:2:0) after 1m0s
[16:59:17.844] Received PubSub notification, asking Buildbucket for the build status
[16:59:18.847] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:09.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:2:0)
[17:00:09.701] Timer tick, asking Buildbucket for the build status
[17:00:09.974] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:09.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:4:0) after 1m0s
[17:01:10.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:4:0)
[17:01:10.027] Timer tick, asking Buildbucket for the build status
[17:01:10.271] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:10.271] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:5:0) after 1m0s
[17:02:10.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:5:0)
[17:02:10.297] Timer tick, asking Buildbucket for the build status
[17:02:12.654] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:12.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:6:0) after 1m0s
[17:03:12.651] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:6:0)
[17:03:12.651] Timer tick, asking Buildbucket for the build status
[17:03:12.968] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:12.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:7:0) after 1m0s
[17:04:12.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:7:0)
[17:04:12.990] Timer tick, asking Buildbucket for the build status
[17:04:14.487] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:14.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:8:0) after 1m0s
[17:05:14.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:8:0)
[17:05:14.538] Timer tick, asking Buildbucket for the build status
[17:05:15.436] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:15.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:9:0) after 1m0s
[17:06:15.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:9:0)
[17:06:15.531] Timer tick, asking Buildbucket for the build status
[17:06:16.136] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:16.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:10:0) after 1m0s
[17:07:16.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:10:0)
[17:07:16.156] Timer tick, asking Buildbucket for the build status
[17:07:16.380] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:16.380] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:11:0) after 1m0s
[17:08:16.403] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:11:0)
[17:08:16.403] Timer tick, asking Buildbucket for the build status
[17:08:16.621] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:16.621] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:12:0) after 1m0s
[17:09:17.685] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:12:0)
[17:09:17.685] Timer tick, asking Buildbucket for the build status
[17:09:24.868] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:24.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:13:0) after 1m0s
[17:10:24.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:13:0)
[17:10:24.979] Timer tick, asking Buildbucket for the build status
[17:10:25.677] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:25.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:14:0) after 1m0s
[17:11:25.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:14:0)
[17:11:25.754] Timer tick, asking Buildbucket for the build status
[17:11:29.798] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:29.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:15:0) after 1m0s
[17:12:29.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:15:0)
[17:12:29.944] Timer tick, asking Buildbucket for the build status
[17:12:30.383] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:30.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:16:0) after 1m0s
[17:13:30.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:16:0)
[17:13:30.455] Timer tick, asking Buildbucket for the build status
[17:13:30.724] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:30.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:17:0) after 1m0s
[17:14:30.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:17:0)
[17:14:30.951] Timer tick, asking Buildbucket for the build status
[17:14:31.143] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:31.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:18:0) after 1m0s
[17:15:31.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:18:0)
[17:15:31.275] Timer tick, asking Buildbucket for the build status
[17:15:31.925] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:31.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:19:0) after 1m0s
[17:16:32.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:19:0)
[17:16:32.048] Timer tick, asking Buildbucket for the build status
[17:16:32.234] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:32.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:20:0) after 1m0s
[17:17:32.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:20:0)
[17:17:32.273] Timer tick, asking Buildbucket for the build status
[17:17:33.144] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:33.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:21:0) after 1m0s
[17:18:33.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:21:0)
[17:18:33.173] Timer tick, asking Buildbucket for the build status
[17:18:33.415] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:33.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:22:0) after 1m0s
[17:19:33.590] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:22:0)
[17:19:33.590] Timer tick, asking Buildbucket for the build status
[17:19:33.933] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:33.933] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:23:0) after 1m0s
[17:20:34.002] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:23:0)
[17:20:34.002] Timer tick, asking Buildbucket for the build status
[17:20:34.494] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:34.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:24:0) after 1m0s
[17:21:34.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:24:0)
[17:21:34.556] Timer tick, asking Buildbucket for the build status
[17:21:35.276] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:35.276] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:25:0) after 1m0s
[17:22:35.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:25:0)
[17:22:35.302] Timer tick, asking Buildbucket for the build status
[17:22:35.787] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:35.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:26:0) after 1m0s
[17:23:35.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:26:0)
[17:23:35.838] Timer tick, asking Buildbucket for the build status
[17:23:36.577] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:36.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:27:0) after 1m0s
[17:24:36.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:27:0)
[17:24:36.629] Timer tick, asking Buildbucket for the build status
[17:24:36.823] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:36.823] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:28:0) after 1m0s
[17:25:37.017] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:28:0)
[17:25:37.017] Timer tick, asking Buildbucket for the build status
[17:25:37.143] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:37.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:29:0) after 1m0s
[17:26:37.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:29:0)
[17:26:37.231] Timer tick, asking Buildbucket for the build status
[17:26:37.362] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:37.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:30:0) after 1m0s
[17:27:37.562] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:30:0)
[17:27:37.562] Timer tick, asking Buildbucket for the build status
[17:27:37.667] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:37.667] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:31:0) after 1m0s
[17:28:37.940] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:31:0)
[17:28:37.940] Timer tick, asking Buildbucket for the build status
[17:28:38.409] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:38.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:32:0) after 1m0s
[17:29:38.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:32:0)
[17:29:38.446] Timer tick, asking Buildbucket for the build status
[17:29:38.971] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:38.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:33:0) after 1m0s
[17:30:39.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:33:0)
[17:30:39.199] Timer tick, asking Buildbucket for the build status
[17:30:39.524] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:39.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:34:0) after 1m0s
[17:31:39.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:34:0)
[17:31:39.554] Timer tick, asking Buildbucket for the build status
[17:31:39.834] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:39.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:35:0) after 1m0s
[17:32:39.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:35:0)
[17:32:39.917] Timer tick, asking Buildbucket for the build status
[17:32:40.242] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:40.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:36:0) after 1m0s
[17:33:40.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:36:0)
[17:33:40.321] Timer tick, asking Buildbucket for the build status
[17:33:40.635] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:40.635] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:37:0) after 1m0s
[17:34:40.698] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:37:0)
[17:34:40.698] Timer tick, asking Buildbucket for the build status
[17:34:43.296] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:43.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:38:0) after 1m0s
[17:35:43.511] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:38:0)
[17:35:43.511] Timer tick, asking Buildbucket for the build status
[17:35:43.668] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:43.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:39:0) after 1m0s
[17:36:43.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:39:0)
[17:36:43.699] Timer tick, asking Buildbucket for the build status
[17:36:43.861] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:43.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:40:0) after 1m0s
[17:37:43.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:40:0)
[17:37:43.958] Timer tick, asking Buildbucket for the build status
[17:37:44.116] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:44.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:41:0) after 1m0s
[17:38:44.214] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:41:0)
[17:38:44.214] Timer tick, asking Buildbucket for the build status
[17:38:44.390] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:44.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:42:0) after 1m0s
[17:39:44.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:42:0)
[17:39:44.507] Timer tick, asking Buildbucket for the build status
[17:39:45.220] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:45.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:43:0) after 1m0s
[17:40:45.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:43:0)
[17:40:45.336] Timer tick, asking Buildbucket for the build status
[17:40:45.512] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:45.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:44:0) after 1m0s
[17:41:45.686] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:44:0)
[17:41:45.686] Timer tick, asking Buildbucket for the build status
[17:41:46.620] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:46.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:45:0) after 1m0s
[17:42:46.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:45:0)
[17:42:46.716] Timer tick, asking Buildbucket for the build status
[17:42:48.674] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:48.674] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:46:0) after 1m0s
[17:43:48.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:46:0)
[17:43:48.820] Timer tick, asking Buildbucket for the build status
[17:43:49.222] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:49.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:47:0) after 1m0s
[17:44:49.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:47:0)
[17:44:49.330] Timer tick, asking Buildbucket for the build status
[17:44:49.656] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:49.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:48:0) after 1m0s
[17:45:49.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:48:0)
[17:45:49.819] Timer tick, asking Buildbucket for the build status
[17:45:50.314] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:50.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:49:0) after 1m0s
[17:46:50.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:49:0)
[17:46:50.457] Timer tick, asking Buildbucket for the build status
[17:46:50.758] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:50.758] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:50:0) after 1m0s
[17:47:50.834] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:50:0)
[17:47:50.834] Timer tick, asking Buildbucket for the build status
[17:47:51.073] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:51.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:51:0) after 1m0s
[17:48:51.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:51:0)
[17:48:51.177] Timer tick, asking Buildbucket for the build status
[17:48:52.115] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:52.115] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:52:0) after 1m0s
[17:49:52.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:52:0)
[17:49:52.250] Timer tick, asking Buildbucket for the build status
[17:49:52.427] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:52.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:53:0) after 1m0s
[17:50:52.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:53:0)
[17:50:52.455] Timer tick, asking Buildbucket for the build status
[17:50:53.708] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:53.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:54:0) after 1m0s
[17:51:53.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:54:0)
[17:51:53.750] Timer tick, asking Buildbucket for the build status
[17:51:54.377] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:54.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:55:0) after 1m0s
[17:52:54.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:55:0)
[17:52:54.405] Timer tick, asking Buildbucket for the build status
[17:52:54.534] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:54.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:56:0) after 1m0s
[17:53:54.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:56:0)
[17:53:54.556] Timer tick, asking Buildbucket for the build status
[17:53:54.697] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:54.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:57:0) after 1m0s
[17:54:54.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:57:0)
[17:54:54.757] Timer tick, asking Buildbucket for the build status
[17:54:54.870] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:54.870] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:58:0) after 1m0s
[17:55:54.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:58:0)
[17:55:54.910] Timer tick, asking Buildbucket for the build status
[17:55:55.013] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:55.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:59:0) after 1m0s
[17:56:55.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:59:0)
[17:56:55.075] Timer tick, asking Buildbucket for the build status
[17:56:56.240] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:56.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:60:0) after 1m0s
[17:57:56.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:60:0)
[17:57:56.332] Timer tick, asking Buildbucket for the build status
[17:57:56.650] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:56.650] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:61:0) after 1m0s
[17:58:56.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:61:0)
[17:58:56.694] Timer tick, asking Buildbucket for the build status
[17:58:56.837] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:56.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:62:0) after 1m0s
[17:59:57.033] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:62:0)
[17:59:57.033] Timer tick, asking Buildbucket for the build status
[17:59:57.510] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:57.510] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:63:0) after 1m0s
[18:00:57.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:63:0)
[18:00:57.765] Timer tick, asking Buildbucket for the build status
[18:00:59.963] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:59.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:64:0) after 1m0s
[18:02:00.038] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:64:0)
[18:02:00.038] Timer tick, asking Buildbucket for the build status
[18:02:00.342] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:00.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:65:0) after 1m0s
[18:03:00.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:65:0)
[18:03:00.405] Timer tick, asking Buildbucket for the build status
[18:03:01.204] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:01.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:66:0) after 1m0s
[18:04:01.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:66:0)
[18:04:01.206] Timer tick, asking Buildbucket for the build status
[18:04:01.368] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:01.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:67:0) after 1m0s
[18:05:01.367] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:67:0)
[18:05:01.367] Timer tick, asking Buildbucket for the build status
[18:05:05.052] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:05.052] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:68:0) after 1m0s
[18:06:05.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:68:0)
[18:06:05.180] Timer tick, asking Buildbucket for the build status
[18:06:05.416] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:05.416] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:69:0) after 1m0s
[18:07:05.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:69:0)
[18:07:05.446] Timer tick, asking Buildbucket for the build status
[18:07:05.925] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:05.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:70:0) after 1m0s
[18:08:06.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:70:0)
[18:08:06.037] Timer tick, asking Buildbucket for the build status
[18:08:07.254] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:07.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:71:0) after 1m0s
[18:09:07.322] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:71:0)
[18:09:07.322] Timer tick, asking Buildbucket for the build status
[18:09:07.491] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:07.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:72:0) after 1m0s
[18:10:07.539] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:72:0)
[18:10:07.539] Timer tick, asking Buildbucket for the build status
[18:10:07.660] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:07.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:73:0) after 1m0s
[18:11:07.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:73:0)
[18:11:07.699] Timer tick, asking Buildbucket for the build status
[18:11:07.914] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:07.915] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:74:0) after 1m0s
[18:12:07.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:74:0)
[18:12:07.939] Timer tick, asking Buildbucket for the build status
[18:12:08.034] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:08.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:75:0) after 1m0s
[18:13:08.129] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:75:0)
[18:13:08.129] Timer tick, asking Buildbucket for the build status
[18:13:08.504] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:08.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:76:0) after 1m0s
[18:14:08.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:76:0)
[18:14:08.540] Timer tick, asking Buildbucket for the build status
[18:14:08.817] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:08.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:77:0) after 1m0s
[18:15:09.341] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:77:0)
[18:15:09.341] Timer tick, asking Buildbucket for the build status
[18:15:09.551] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:09.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:78:0) after 1m0s
[18:16:09.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:78:0)
[18:16:09.978] Timer tick, asking Buildbucket for the build status
[18:16:10.931] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:10.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:79:0) after 1m0s
[18:17:10.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:79:0)
[18:17:10.973] Timer tick, asking Buildbucket for the build status
[18:17:14.708] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:14.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:80:0) after 1m0s
[18:18:14.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:80:0)
[18:18:14.846] Timer tick, asking Buildbucket for the build status
[18:18:15.153] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:15.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:81:0) after 1m0s
[18:19:15.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:81:0)
[18:19:15.332] Timer tick, asking Buildbucket for the build status
[18:19:15.457] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:15.457] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:82:0) after 1m0s
[18:20:15.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:82:0)
[18:20:15.532] Timer tick, asking Buildbucket for the build status
[18:20:16.676] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:16.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:83:0) after 1m0s
[18:21:16.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:83:0)
[18:21:16.803] Timer tick, asking Buildbucket for the build status
[18:21:17.736] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:17.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:84:0) after 1m0s
[18:22:17.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:84:0)
[18:22:17.790] Timer tick, asking Buildbucket for the build status
[18:22:18.124] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:18.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:85:0) after 1m0s
[18:23:18.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:85:0)
[18:23:18.188] Timer tick, asking Buildbucket for the build status
[18:23:18.868] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:18.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:86:0) after 1m0s
[18:24:18.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:86:0)
[18:24:18.898] Timer tick, asking Buildbucket for the build status
[18:24:19.041] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:19.041] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:87:0) after 1m0s
[18:25:19.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:87:0)
[18:25:19.137] Timer tick, asking Buildbucket for the build status
[18:25:19.986] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:19.986] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:88:0) after 1m0s
[18:26:20.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:88:0)
[18:26:20.083] Timer tick, asking Buildbucket for the build status
[18:26:20.310] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:20.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:89:0) after 1m0s
[18:27:20.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:89:0)
[18:27:20.378] Timer tick, asking Buildbucket for the build status
[18:27:20.496] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:20.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:90:0) after 1m0s
[18:28:20.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:90:0)
[18:28:20.639] Timer tick, asking Buildbucket for the build status
[18:28:21.858] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:21.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:91:0) after 1m0s
[18:29:21.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:91:0)
[18:29:21.845] Timer tick, asking Buildbucket for the build status
[18:29:22.116] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:22.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:92:0) after 1m0s
[18:30:22.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:92:0)
[18:30:22.298] Timer tick, asking Buildbucket for the build status
[18:30:22.395] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:22.395] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:93:0) after 1m0s
[18:31:22.628] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:93:0)
[18:31:22.628] Timer tick, asking Buildbucket for the build status
[18:31:23.482] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:23.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:94:0) after 1m0s
[18:32:23.618] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:94:0)
[18:32:23.618] Timer tick, asking Buildbucket for the build status
[18:32:24.226] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:24.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:95:0) after 1m0s
[18:33:24.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:95:0)
[18:33:24.493] Timer tick, asking Buildbucket for the build status
[18:33:24.803] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:24.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:96:0) after 1m0s
[18:34:24.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:96:0)
[18:34:24.978] Timer tick, asking Buildbucket for the build status
[18:34:28.459] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:28.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:97:0) after 1m0s
[18:35:28.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:97:0)
[18:35:28.598] Timer tick, asking Buildbucket for the build status
[18:35:29.156] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:29.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:98:0) after 1m0s
[18:36:29.209] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:98:0)
[18:36:29.209] Timer tick, asking Buildbucket for the build status
[18:36:29.860] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:29.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:99:0) after 1m0s
[18:37:29.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:99:0)
[18:37:29.871] Timer tick, asking Buildbucket for the build status
[18:37:30.144] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:30.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:100:0) after 1m0s
[18:38:30.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:100:0)
[18:38:30.224] Timer tick, asking Buildbucket for the build status
[18:38:31.155] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:31.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:101:0) after 1m0s
[18:39:31.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:101:0)
[18:39:31.220] Timer tick, asking Buildbucket for the build status
[18:39:32.494] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:32.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:102:0) after 1m0s
[18:40:32.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:102:0)
[18:40:32.592] Timer tick, asking Buildbucket for the build status
[18:40:32.739] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:32.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:103:0) after 1m0s
[18:41:32.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:103:0)
[18:41:32.848] Timer tick, asking Buildbucket for the build status
[18:41:32.996] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:32.996] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:104:0) after 1m0s
[18:42:33.117] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:104:0)
[18:42:33.117] Timer tick, asking Buildbucket for the build status
[18:42:33.717] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:33.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:105:0) after 1m0s
[18:43:33.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:105:0)
[18:43:33.866] Timer tick, asking Buildbucket for the build status
[18:43:34.210] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:34.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:106:0) after 1m0s
[18:44:34.308] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:106:0)
[18:44:34.308] Timer tick, asking Buildbucket for the build status
[18:44:35.641] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:35.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:107:0) after 1m0s
[18:45:35.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:107:0)
[18:45:35.925] Timer tick, asking Buildbucket for the build status
[18:45:36.052] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:36.052] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:108:0) after 1m0s
[18:46:36.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:108:0)
[18:46:36.257] Timer tick, asking Buildbucket for the build status
[18:46:36.493] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:36.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:109:0) after 1m0s
[18:47:36.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:109:0)
[18:47:36.650] Timer tick, asking Buildbucket for the build status
[18:47:37.216] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:37.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:110:0) after 1m0s
[18:48:37.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:110:0)
[18:48:37.250] Timer tick, asking Buildbucket for the build status
[18:48:38.841] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:38.841] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:111:0) after 1m0s
[18:49:39.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:111:0)
[18:49:39.156] Timer tick, asking Buildbucket for the build status
[18:49:39.348] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:39.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:112:0) after 1m0s
[18:50:39.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:112:0)
[18:50:39.455] Timer tick, asking Buildbucket for the build status
[18:50:39.824] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:39.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:113:0) after 1m0s
[18:51:39.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:113:0)
[18:51:39.964] Timer tick, asking Buildbucket for the build status
[18:51:40.379] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:40.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:114:0) after 1m0s
[18:52:40.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:114:0)
[18:52:40.460] Timer tick, asking Buildbucket for the build status
[18:52:40.815] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:40.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:115:0) after 1m0s
[18:53:40.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:115:0)
[18:53:40.854] Timer tick, asking Buildbucket for the build status
[18:53:41.324] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:41.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:116:0) after 1m0s
[18:54:41.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:116:0)
[18:54:41.391] Timer tick, asking Buildbucket for the build status
[18:54:41.621] Build 8910204801778895760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:41.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075634864242086208:117:0) after 1m0s
[18:54:43.023] Received PubSub notification, asking Buildbucket for the build status
[18:54:43.662] Build 8910204801778895760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:54:43.662] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1560970482085363",
"created_by": "project:chromium",
"created_ts": "1560963548831613",
"id": "8910204801778895760",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"de87ca945cfee1a8cf2471e9fffc2597b143e20c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-trusty-8-9-3vwz\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 23791, \"got_angle_revision\": \"f157aba50a524cded8ab2a1e83c63357c8032c25\", \"got_dawn_revision\": \"92cdeaaf810bee05e4b23e99fc2bededbdfa59d4\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"de87ca945cfee1a8cf2471e9fffc2597b143e20c\", \"got_revision_cp\": \"refs/heads/master@{#670527}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"ab5fb228bcaf387cc72dfd93cdc62c1db4867ebf\", \"got_v8_revision_cp\": \"refs/heads/7.7.109@{#1}\", \"got_webrtc_revision\": \"b7a3e3f5c42ae926f5962c69e87bbfa6375a45ba\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28314}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"de87ca945cfee1a8cf2471e9fffc2597b143e20c\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-8-9-3vwz\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4339-6285c57\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1560963553609566",
"status": "COMPLETED",
"status_changed_ts": "1560970482586749",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23791",
"builder:Deterministic Linux",
"buildset:commit/git/de87ca945cfee1a8cf2471e9fffc2597b143e20c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/de87ca945cfee1a8cf2471e9fffc2597b143e20c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075634864242086208",
"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/8910204801778895760/+/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:45897f167b9bc410",
"user_agent:luci-scheduler"
],
"updated_ts": "1560970482590311",
"url": "https://ci.chromium.org/b/8910204801778895760",
"utcnow_ts": "1560970483651325"
}
}
[18:54:43.662] Invocation finished in 1h55m36.563091473s with status SUCCEEDED