[09:45:20.100] New invocation is queued and will start shortly
[09:45:21.199] Starting the invocation (attempt 1)
[09:45:21.265] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:45:21.265] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:45:21.265] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056727389567217952",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1aa2f57c1ae45e03204ae3519c06201e75e32f8e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9056727389567217952",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/1aa2f57c1ae45e03204ae3519c06201e75e32f8e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1aa2f57c1ae45e03204ae3519c06201e75e32f8e",
"gitiles_ref:refs/heads/master"
]
}
[09:45:22.903] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578995121899111",
"id": "8891297327018286272",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1aa2f57c1ae45e03204ae3519c06201e75e32f8e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578995122709098",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26462",
"builder:Deterministic Linux",
"buildset:commit/git/1aa2f57c1ae45e03204ae3519c06201e75e32f8e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1aa2f57c1ae45e03204ae3519c06201e75e32f8e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056727389567217952",
"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/8891297327018286272/+/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": "1578995122709223",
"url": "https://ci.chromium.org/b/8891297327018286272",
"utcnow_ts": "1578995122883514"
}
}
[09:45:22.903] Task URL: https://ci.chromium.org/b/8891297327018286272
[09:45:22.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:2:0) after 1m0s
[09:45:56.645] Received PubSub notification, asking Buildbucket for the build status
[09:45:57.523] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:23.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:2:0)
[09:46:23.101] Timer tick, asking Buildbucket for the build status
[09:46:23.418] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:23.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:4:0) after 1m0s
[09:47:23.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:4:0)
[09:47:23.471] Timer tick, asking Buildbucket for the build status
[09:47:24.878] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:24.878] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:5:0) after 1m0s
[09:48:24.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:5:0)
[09:48:24.953] Timer tick, asking Buildbucket for the build status
[09:48:25.469] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:25.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:6:0) after 1m0s
[09:49:25.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:6:0)
[09:49:25.572] Timer tick, asking Buildbucket for the build status
[09:49:25.917] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:25.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:7:0) after 1m0s
[09:50:25.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:7:0)
[09:50:25.924] Timer tick, asking Buildbucket for the build status
[09:50:26.163] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:26.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:8:0) after 1m0s
[09:51:26.223] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:8:0)
[09:51:26.223] Timer tick, asking Buildbucket for the build status
[09:51:26.395] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:26.395] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:9:0) after 1m0s
[09:52:26.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:9:0)
[09:52:26.414] Timer tick, asking Buildbucket for the build status
[09:52:26.588] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:26.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:10:0) after 1m0s
[09:53:26.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:10:0)
[09:53:26.656] Timer tick, asking Buildbucket for the build status
[09:53:26.848] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:26.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:11:0) after 1m0s
[09:54:26.900] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:11:0)
[09:54:26.900] Timer tick, asking Buildbucket for the build status
[09:54:27.853] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:27.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:12:0) after 1m0s
[09:55:28.016] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:12:0)
[09:55:28.016] Timer tick, asking Buildbucket for the build status
[09:55:29.568] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:29.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:13:0) after 1m0s
[09:56:29.559] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:13:0)
[09:56:29.559] Timer tick, asking Buildbucket for the build status
[09:56:29.716] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:29.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:14:0) after 1m0s
[09:57:29.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:14:0)
[09:57:29.792] Timer tick, asking Buildbucket for the build status
[09:57:29.994] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:29.994] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:15:0) after 1m0s
[09:58:30.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:15:0)
[09:58:30.067] Timer tick, asking Buildbucket for the build status
[09:58:30.813] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:30.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:16:0) after 1m0s
[09:59:30.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:16:0)
[09:59:30.937] Timer tick, asking Buildbucket for the build status
[09:59:31.443] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:31.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:17:0) after 1m0s
[10:00:31.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:17:0)
[10:00:31.580] Timer tick, asking Buildbucket for the build status
[10:00:32.597] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:32.597] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:18:0) after 1m0s
[10:01:32.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:18:0)
[10:01:32.648] Timer tick, asking Buildbucket for the build status
[10:01:33.047] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:33.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:19:0) after 1m0s
[10:02:33.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:19:0)
[10:02:33.123] Timer tick, asking Buildbucket for the build status
[10:02:33.359] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:33.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:20:0) after 1m0s
[10:03:33.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:20:0)
[10:03:33.389] Timer tick, asking Buildbucket for the build status
[10:03:33.727] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:33.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:21:0) after 1m0s
[10:04:33.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:21:0)
[10:04:33.731] Timer tick, asking Buildbucket for the build status
[10:04:33.948] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:33.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:22:0) after 1m0s
[10:05:34.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:22:0)
[10:05:34.008] Timer tick, asking Buildbucket for the build status
[10:05:34.777] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:34.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:23:0) after 1m0s
[10:06:34.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:23:0)
[10:06:34.824] Timer tick, asking Buildbucket for the build status
[10:06:37.727] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:37.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:24:0) after 1m0s
[10:07:37.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:24:0)
[10:07:37.819] Timer tick, asking Buildbucket for the build status
[10:07:37.950] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:37.950] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:25:0) after 1m0s
[10:08:37.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:25:0)
[10:08:37.991] Timer tick, asking Buildbucket for the build status
[10:08:38.680] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:38.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:26:0) after 1m0s
[10:09:38.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:26:0)
[10:09:38.741] Timer tick, asking Buildbucket for the build status
[10:09:39.389] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:39.389] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:27:0) after 1m0s
[10:10:39.440] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:27:0)
[10:10:39.440] Timer tick, asking Buildbucket for the build status
[10:10:39.918] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:39.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:28:0) after 1m0s
[10:11:40.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:28:0)
[10:11:40.008] Timer tick, asking Buildbucket for the build status
[10:11:40.610] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:40.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:29:0) after 1m0s
[10:12:40.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:29:0)
[10:12:40.675] Timer tick, asking Buildbucket for the build status
[10:12:41.000] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:41.000] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:30:0) after 1m0s
[10:13:41.061] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:30:0)
[10:13:41.061] Timer tick, asking Buildbucket for the build status
[10:13:41.507] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:41.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:31:0) after 1m0s
[10:14:41.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:31:0)
[10:14:41.752] Timer tick, asking Buildbucket for the build status
[10:14:41.977] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:41.977] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:32:0) after 1m0s
[10:15:42.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:32:0)
[10:15:42.084] Timer tick, asking Buildbucket for the build status
[10:15:42.577] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:42.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:33:0) after 1m0s
[10:16:42.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:33:0)
[10:16:42.729] Timer tick, asking Buildbucket for the build status
[10:16:42.844] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:42.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:34:0) after 1m0s
[10:17:42.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:34:0)
[10:17:42.911] Timer tick, asking Buildbucket for the build status
[10:17:44.273] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:44.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:35:0) after 1m0s
[10:18:44.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:35:0)
[10:18:44.293] Timer tick, asking Buildbucket for the build status
[10:18:44.583] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:44.583] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:36:0) after 1m0s
[10:19:44.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:36:0)
[10:19:44.743] Timer tick, asking Buildbucket for the build status
[10:19:45.074] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:45.074] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:37:0) after 1m0s
[10:20:45.191] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:37:0)
[10:20:45.191] Timer tick, asking Buildbucket for the build status
[10:20:46.611] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:46.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:38:0) after 1m0s
[10:21:46.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:38:0)
[10:21:46.649] Timer tick, asking Buildbucket for the build status
[10:21:46.956] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:46.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:39:0) after 1m0s
[10:22:47.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:39:0)
[10:22:47.099] Timer tick, asking Buildbucket for the build status
[10:22:47.551] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:47.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:40:0) after 1m0s
[10:23:47.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:40:0)
[10:23:47.700] Timer tick, asking Buildbucket for the build status
[10:23:48.361] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:48.361] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:41:0) after 1m0s
[10:24:48.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:41:0)
[10:24:48.586] Timer tick, asking Buildbucket for the build status
[10:24:48.716] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:48.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:42:0) after 1m0s
[10:25:49.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:42:0)
[10:25:49.011] Timer tick, asking Buildbucket for the build status
[10:25:49.272] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:49.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:43:0) after 1m0s
[10:26:49.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:43:0)
[10:26:49.569] Timer tick, asking Buildbucket for the build status
[10:26:50.210] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:50.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:44:0) after 1m0s
[10:27:50.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:44:0)
[10:27:50.369] Timer tick, asking Buildbucket for the build status
[10:27:50.698] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:50.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:45:0) after 1m0s
[10:28:50.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:45:0)
[10:28:50.837] Timer tick, asking Buildbucket for the build status
[10:28:51.105] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:51.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:46:0) after 1m0s
[10:29:51.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:46:0)
[10:29:51.242] Timer tick, asking Buildbucket for the build status
[10:29:51.418] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:51.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:47:0) after 1m0s
[10:30:51.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:47:0)
[10:30:51.488] Timer tick, asking Buildbucket for the build status
[10:30:53.992] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:53.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:48:0) after 1m0s
[10:31:54.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:48:0)
[10:31:54.083] Timer tick, asking Buildbucket for the build status
[10:31:54.409] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:54.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:49:0) after 1m0s
[10:32:54.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:49:0)
[10:32:54.586] Timer tick, asking Buildbucket for the build status
[10:32:55.888] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:55.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:50:0) after 1m0s
[10:33:56.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:50:0)
[10:33:56.045] Timer tick, asking Buildbucket for the build status
[10:33:56.248] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:56.248] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:51:0) after 1m0s
[10:34:56.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:51:0)
[10:34:56.312] Timer tick, asking Buildbucket for the build status
[10:34:56.569] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:56.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:52:0) after 1m0s
[10:35:56.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:52:0)
[10:35:56.622] Timer tick, asking Buildbucket for the build status
[10:35:56.797] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:56.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:53:0) after 1m0s
[10:36:56.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:53:0)
[10:36:56.874] Timer tick, asking Buildbucket for the build status
[10:36:57.087] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:57.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:54:0) after 1m0s
[10:37:57.187] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:54:0)
[10:37:57.187] Timer tick, asking Buildbucket for the build status
[10:37:57.626] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:57.626] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:55:0) after 1m0s
[10:38:57.826] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:55:0)
[10:38:57.826] Timer tick, asking Buildbucket for the build status
[10:38:58.078] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:58.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:56:0) after 1m0s
[10:39:58.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:56:0)
[10:39:58.177] Timer tick, asking Buildbucket for the build status
[10:39:58.474] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:58.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:57:0) after 1m0s
[10:40:58.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:57:0)
[10:40:58.570] Timer tick, asking Buildbucket for the build status
[10:40:58.867] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:58.867] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:58:0) after 1m0s
[10:41:58.947] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:58:0)
[10:41:58.947] Timer tick, asking Buildbucket for the build status
[10:41:59.120] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:59.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:59:0) after 1m0s
[10:42:59.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:59:0)
[10:42:59.459] Timer tick, asking Buildbucket for the build status
[10:42:59.628] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:59.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:60:0) after 1m0s
[10:43:59.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:60:0)
[10:43:59.765] Timer tick, asking Buildbucket for the build status
[10:44:00.922] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:00.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:61:0) after 1m0s
[10:45:01.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:61:0)
[10:45:01.059] Timer tick, asking Buildbucket for the build status
[10:45:01.304] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:01.304] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:62:0) after 1m0s
[10:46:02.070] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:62:0)
[10:46:02.070] Timer tick, asking Buildbucket for the build status
[10:46:02.286] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:02.287] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:63:0) after 1m0s
[10:47:02.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:63:0)
[10:47:02.699] Timer tick, asking Buildbucket for the build status
[10:47:02.970] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:02.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:64:0) after 1m0s
[10:48:03.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:64:0)
[10:48:03.044] Timer tick, asking Buildbucket for the build status
[10:48:03.690] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:03.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:65:0) after 1m0s
[10:49:03.776] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:65:0)
[10:49:03.776] Timer tick, asking Buildbucket for the build status
[10:49:04.376] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:04.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:66:0) after 1m0s
[10:50:04.425] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:66:0)
[10:50:04.425] Timer tick, asking Buildbucket for the build status
[10:50:04.573] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:04.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:67:0) after 1m0s
[10:51:04.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:67:0)
[10:51:04.730] Timer tick, asking Buildbucket for the build status
[10:51:05.687] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:05.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:68:0) after 1m0s
[10:52:06.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:68:0)
[10:52:06.043] Timer tick, asking Buildbucket for the build status
[10:52:06.376] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:06.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:69:0) after 1m0s
[10:53:06.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:69:0)
[10:53:06.612] Timer tick, asking Buildbucket for the build status
[10:53:06.768] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:06.768] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:70:0) after 1m0s
[10:54:06.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:70:0)
[10:54:06.930] Timer tick, asking Buildbucket for the build status
[10:54:07.143] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:07.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:71:0) after 1m0s
[10:55:07.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:71:0)
[10:55:07.266] Timer tick, asking Buildbucket for the build status
[10:55:07.755] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:07.755] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:72:0) after 1m0s
[10:56:07.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:72:0)
[10:56:07.806] Timer tick, asking Buildbucket for the build status
[10:56:07.931] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:07.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:73:0) after 1m0s
[10:57:08.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:73:0)
[10:57:08.060] Timer tick, asking Buildbucket for the build status
[10:57:09.459] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:09.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:74:0) after 1m0s
[10:58:09.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:74:0)
[10:58:09.575] Timer tick, asking Buildbucket for the build status
[10:58:10.636] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:10.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:75:0) after 1m0s
[10:59:10.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:75:0)
[10:59:10.693] Timer tick, asking Buildbucket for the build status
[10:59:10.968] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:10.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:76:0) after 1m0s
[11:00:11.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:76:0)
[11:00:11.317] Timer tick, asking Buildbucket for the build status
[11:00:12.004] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:12.004] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:77:0) after 1m0s
[11:01:12.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:77:0)
[11:01:12.532] Timer tick, asking Buildbucket for the build status
[11:01:13.005] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:13.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:78:0) after 1m0s
[11:02:13.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:78:0)
[11:02:13.222] Timer tick, asking Buildbucket for the build status
[11:02:14.433] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:14.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:79:0) after 1m0s
[11:03:14.753] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:79:0)
[11:03:14.753] Timer tick, asking Buildbucket for the build status
[11:03:14.980] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:14.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:80:0) after 1m0s
[11:04:15.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:80:0)
[11:04:15.162] Timer tick, asking Buildbucket for the build status
[11:04:15.460] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:15.460] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:81:0) after 1m0s
[11:05:15.518] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:81:0)
[11:05:15.518] Timer tick, asking Buildbucket for the build status
[11:05:15.847] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:15.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:82:0) after 1m0s
[11:06:15.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:82:0)
[11:06:15.986] Timer tick, asking Buildbucket for the build status
[11:06:16.253] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:16.253] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:83:0) after 1m0s
[11:07:16.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:83:0)
[11:07:16.284] Timer tick, asking Buildbucket for the build status
[11:07:16.479] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:16.479] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:84:0) after 1m0s
[11:08:16.599] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:84:0)
[11:08:16.599] Timer tick, asking Buildbucket for the build status
[11:08:16.788] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:16.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:85:0) after 1m0s
[11:09:16.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:85:0)
[11:09:16.829] Timer tick, asking Buildbucket for the build status
[11:09:21.449] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:21.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:86:0) after 1m0s
[11:10:21.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:86:0)
[11:10:21.663] Timer tick, asking Buildbucket for the build status
[11:10:22.191] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:22.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:87:0) after 1m0s
[11:11:22.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:87:0)
[11:11:22.298] Timer tick, asking Buildbucket for the build status
[11:11:22.463] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:22.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:88:0) after 1m0s
[11:12:22.618] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:88:0)
[11:12:22.618] Timer tick, asking Buildbucket for the build status
[11:12:23.085] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:23.085] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:89:0) after 1m0s
[11:13:23.249] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:89:0)
[11:13:23.250] Timer tick, asking Buildbucket for the build status
[11:13:23.616] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:23.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:90:0) after 1m0s
[11:14:23.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:90:0)
[11:14:23.680] Timer tick, asking Buildbucket for the build status
[11:14:23.943] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:23.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:91:0) after 1m0s
[11:15:23.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:91:0)
[11:15:23.985] Timer tick, asking Buildbucket for the build status
[11:15:24.267] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:24.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:92:0) after 1m0s
[11:16:24.289] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:92:0)
[11:16:24.289] Timer tick, asking Buildbucket for the build status
[11:16:24.651] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:24.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:93:0) after 1m0s
[11:17:24.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:93:0)
[11:17:24.660] Timer tick, asking Buildbucket for the build status
[11:17:24.843] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:24.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:94:0) after 1m0s
[11:18:24.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:94:0)
[11:18:24.930] Timer tick, asking Buildbucket for the build status
[11:18:25.400] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:25.400] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:95:0) after 1m0s
[11:19:25.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:95:0)
[11:19:25.463] Timer tick, asking Buildbucket for the build status
[11:19:25.899] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:25.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:96:0) after 1m0s
[11:20:25.960] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:96:0)
[11:20:25.960] Timer tick, asking Buildbucket for the build status
[11:20:26.187] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:26.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:97:0) after 1m0s
[11:21:26.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:97:0)
[11:21:26.257] Timer tick, asking Buildbucket for the build status
[11:21:26.836] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:26.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:98:0) after 1m0s
[11:22:26.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:98:0)
[11:22:26.897] Timer tick, asking Buildbucket for the build status
[11:22:27.116] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:27.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:99:0) after 1m0s
[11:23:27.165] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:99:0)
[11:23:27.165] Timer tick, asking Buildbucket for the build status
[11:23:27.377] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:27.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:100:0) after 1m0s
[11:24:27.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:100:0)
[11:24:27.364] Timer tick, asking Buildbucket for the build status
[11:24:27.733] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:27.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:101:0) after 1m0s
[11:25:27.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:101:0)
[11:25:27.817] Timer tick, asking Buildbucket for the build status
[11:25:28.028] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:28.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:102:0) after 1m0s
[11:26:28.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:102:0)
[11:26:28.154] Timer tick, asking Buildbucket for the build status
[11:26:28.392] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:28.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:103:0) after 1m0s
[11:27:28.403] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:103:0)
[11:27:28.403] Timer tick, asking Buildbucket for the build status
[11:27:28.796] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:28.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:104:0) after 1m0s
[11:28:28.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:104:0)
[11:28:28.876] Timer tick, asking Buildbucket for the build status
[11:28:29.113] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:29.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:105:0) after 1m0s
[11:29:29.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:105:0)
[11:29:29.178] Timer tick, asking Buildbucket for the build status
[11:29:29.348] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:29.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:106:0) after 1m0s
[11:30:29.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:106:0)
[11:30:29.378] Timer tick, asking Buildbucket for the build status
[11:30:30.127] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:30.127] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:107:0) after 1m0s
[11:31:30.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:107:0)
[11:31:30.153] Timer tick, asking Buildbucket for the build status
[11:31:30.423] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:30.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:108:0) after 1m0s
[11:32:30.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:108:0)
[11:32:30.486] Timer tick, asking Buildbucket for the build status
[11:32:32.520] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:32.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:109:0) after 1m0s
[11:33:32.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:109:0)
[11:33:32.604] Timer tick, asking Buildbucket for the build status
[11:33:33.604] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:33.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:110:0) after 1m0s
[11:34:33.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:110:0)
[11:34:33.632] Timer tick, asking Buildbucket for the build status
[11:34:33.804] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:33.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:111:0) after 1m0s
[11:35:33.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:111:0)
[11:35:33.841] Timer tick, asking Buildbucket for the build status
[11:35:34.091] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:34.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:112:0) after 1m0s
[11:36:35.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:112:0)
[11:36:35.259] Timer tick, asking Buildbucket for the build status
[11:36:35.903] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:35.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:113:0) after 1m0s
[11:37:35.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:113:0)
[11:37:35.982] Timer tick, asking Buildbucket for the build status
[11:37:36.764] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:36.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:114:0) after 1m0s
[11:38:36.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:114:0)
[11:38:36.819] Timer tick, asking Buildbucket for the build status
[11:38:37.409] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:37.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:115:0) after 1m0s
[11:39:37.545] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:115:0)
[11:39:37.546] Timer tick, asking Buildbucket for the build status
[11:39:38.474] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:38.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:116:0) after 1m0s
[11:40:38.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:116:0)
[11:40:38.507] Timer tick, asking Buildbucket for the build status
[11:40:39.467] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:39.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:117:0) after 1m0s
[11:41:39.560] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:117:0)
[11:41:39.560] Timer tick, asking Buildbucket for the build status
[11:41:39.764] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:39.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:118:0) after 1m0s
[11:42:40.116] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:118:0)
[11:42:40.116] Timer tick, asking Buildbucket for the build status
[11:42:40.360] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:40.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:119:0) after 1m0s
[11:43:40.772] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:119:0)
[11:43:40.772] Timer tick, asking Buildbucket for the build status
[11:43:41.348] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:41.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:120:0) after 1m0s
[11:44:41.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:120:0)
[11:44:41.742] Timer tick, asking Buildbucket for the build status
[11:44:42.279] Build 8891297327018286272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:42.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9056727389567217952:121:0) after 1m0s
[11:45:14.932] Received PubSub notification, asking Buildbucket for the build status
[11:45:15.563] Build 8891297327018286272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:45:15.563] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579002313673918",
"created_by": "project:chromium",
"created_ts": "1578995121899111",
"id": "8891297327018286272",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1aa2f57c1ae45e03204ae3519c06201e75e32f8e\"}}",
"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-xenial-us-central1-b-8-20-5wyc\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26462, \"got_angle_revision\": \"8b3a0fa8105082771d4a0d39cf87cf9c74c8f139\", \"got_dawn_revision\": \"e5cb8f2eff7e2b0f672c0d20fb97ca17fe28e94a\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"1aa2f57c1ae45e03204ae3519c06201e75e32f8e\", \"got_revision_cp\": \"refs/heads/master@{#731183}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"488d35ac0b1c66c79a6a8511111ad5b6296a2ffb\", \"got_v8_revision\": \"3d04bd15b02d40f716b49dbb1cb97bb13c40741a\", \"got_v8_revision_cp\": \"refs/heads/8.1.170@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1aa2f57c1ae45e03204ae3519c06201e75e32f8e\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-20-5wyc\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578995155929547",
"status": "COMPLETED",
"status_changed_ts": "1579002314113367",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26462",
"builder:Deterministic Linux",
"buildset:commit/git/1aa2f57c1ae45e03204ae3519c06201e75e32f8e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1aa2f57c1ae45e03204ae3519c06201e75e32f8e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056727389567217952",
"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/8891297327018286272/+/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:49bc438526f42b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1579002314182192",
"url": "https://ci.chromium.org/b/8891297327018286272",
"utcnow_ts": "1579002315506510"
}
}
[11:45:15.563] Invocation finished in 1h59m55.479568086s with status SUCCEEDED