[21:15:02.347] New invocation is queued and will start shortly
[21:15:03.455] Starting the invocation (attempt 1)
[21:15:03.498] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:15:03.498] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:15:03.498] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059673697040603120",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"da3dfd0675d74d114764cb0b84a937e883e376ff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9059673697040603120",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/da3dfd0675d74d114764cb0b84a937e883e376ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/da3dfd0675d74d114764cb0b84a937e883e376ff",
"gitiles_ref:refs/heads/master"
]
}
[21:15:04.283] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576185303630943",
"id": "8894243635019626224",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"da3dfd0675d74d114764cb0b84a937e883e376ff\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576185304060657",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26047",
"builder:Deterministic Linux",
"buildset:commit/git/da3dfd0675d74d114764cb0b84a937e883e376ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/da3dfd0675d74d114764cb0b84a937e883e376ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059673697040603120",
"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/8894243635019626224/+/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": "1576185304060760",
"url": "https://ci.chromium.org/b/8894243635019626224",
"utcnow_ts": "1576185304274891"
}
}
[21:15:04.283] Task URL: https://ci.chromium.org/b/8894243635019626224
[21:15:04.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:2:0) after 1m0s
[21:16:04.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:2:0)
[21:16:04.363] Timer tick, asking Buildbucket for the build status
[21:16:05.020] Build 8894243635019626224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:05.020] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:3:0) after 1m0s
[21:17:05.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:3:0)
[21:17:05.142] Timer tick, asking Buildbucket for the build status
[21:17:05.377] Build 8894243635019626224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:05.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:4:0) after 1m0s
[21:18:05.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:4:0)
[21:18:05.451] Timer tick, asking Buildbucket for the build status
[21:18:05.724] Build 8894243635019626224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:05.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:5:0) after 1m0s
[21:19:05.764] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:5:0)
[21:19:05.764] Timer tick, asking Buildbucket for the build status
[21:19:05.919] Build 8894243635019626224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:05.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:6:0) after 1m0s
[21:20:03.683] Received PubSub notification, asking Buildbucket for the build status
[21:20:04.001] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:06.187] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:6:0)
[21:20:06.187] Timer tick, asking Buildbucket for the build status
[21:20:06.316] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:06.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:8:0) after 1m0s
[21:21:06.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:8:0)
[21:21:06.442] Timer tick, asking Buildbucket for the build status
[21:21:06.733] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:06.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:9:0) after 1m0s
[21:22:06.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:9:0)
[21:22:06.907] Timer tick, asking Buildbucket for the build status
[21:22:07.083] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:07.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:10:0) after 1m0s
[21:23:07.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:10:0)
[21:23:07.239] Timer tick, asking Buildbucket for the build status
[21:23:07.607] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:07.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:11:0) after 1m0s
[21:24:07.690] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:11:0)
[21:24:07.690] Timer tick, asking Buildbucket for the build status
[21:24:07.911] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:07.911] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:12:0) after 1m0s
[21:25:07.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:12:0)
[21:25:07.958] Timer tick, asking Buildbucket for the build status
[21:25:08.392] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:08.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:13:0) after 1m0s
[21:26:08.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:13:0)
[21:26:08.470] Timer tick, asking Buildbucket for the build status
[21:26:08.673] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:08.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:14:0) after 1m0s
[21:27:08.828] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:14:0)
[21:27:08.828] Timer tick, asking Buildbucket for the build status
[21:27:09.034] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:09.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:15:0) after 1m0s
[21:28:09.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:15:0)
[21:28:09.466] Timer tick, asking Buildbucket for the build status
[21:28:09.781] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:09.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:16:0) after 1m0s
[21:29:09.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:16:0)
[21:29:09.988] Timer tick, asking Buildbucket for the build status
[21:29:10.230] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:10.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:17:0) after 1m0s
[21:30:10.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:17:0)
[21:30:10.328] Timer tick, asking Buildbucket for the build status
[21:30:10.668] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:10.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:18:0) after 1m0s
[21:31:11.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:18:0)
[21:31:11.390] Timer tick, asking Buildbucket for the build status
[21:31:11.837] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:11.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:19:0) after 1m0s
[21:32:12.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:19:0)
[21:32:12.115] Timer tick, asking Buildbucket for the build status
[21:32:12.371] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:12.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:20:0) after 1m0s
[21:33:12.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:20:0)
[21:33:12.625] Timer tick, asking Buildbucket for the build status
[21:33:12.849] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:12.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:21:0) after 1m0s
[21:34:13.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:21:0)
[21:34:13.179] Timer tick, asking Buildbucket for the build status
[21:34:13.374] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:13.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:22:0) after 1m0s
[21:35:13.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:22:0)
[21:35:13.411] Timer tick, asking Buildbucket for the build status
[21:35:13.621] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:13.621] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:23:0) after 1m0s
[21:36:13.641] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:23:0)
[21:36:13.641] Timer tick, asking Buildbucket for the build status
[21:36:14.119] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:14.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:24:0) after 1m0s
[21:37:14.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:24:0)
[21:37:14.169] Timer tick, asking Buildbucket for the build status
[21:37:14.464] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:14.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:25:0) after 1m0s
[21:38:14.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:25:0)
[21:38:14.677] Timer tick, asking Buildbucket for the build status
[21:38:14.851] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:14.851] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:26:0) after 1m0s
[21:39:15.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:26:0)
[21:39:15.264] Timer tick, asking Buildbucket for the build status
[21:39:15.487] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:15.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:27:0) after 1m0s
[21:40:15.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:27:0)
[21:40:15.908] Timer tick, asking Buildbucket for the build status
[21:40:17.632] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:17.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:28:0) after 1m0s
[21:41:17.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:28:0)
[21:41:17.875] Timer tick, asking Buildbucket for the build status
[21:41:18.084] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:18.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:29:0) after 1m0s
[21:42:18.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:29:0)
[21:42:18.162] Timer tick, asking Buildbucket for the build status
[21:42:18.754] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:18.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:30:0) after 1m0s
[21:43:18.843] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:30:0)
[21:43:18.843] Timer tick, asking Buildbucket for the build status
[21:43:19.667] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:19.667] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:31:0) after 1m0s
[21:44:19.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:31:0)
[21:44:19.810] Timer tick, asking Buildbucket for the build status
[21:44:19.979] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:19.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:32:0) after 1m0s
[21:45:20.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:32:0)
[21:45:20.137] Timer tick, asking Buildbucket for the build status
[21:45:21.065] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:21.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:33:0) after 1m0s
[21:46:21.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:33:0)
[21:46:21.430] Timer tick, asking Buildbucket for the build status
[21:46:21.951] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:21.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:34:0) after 1m0s
[21:47:22.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:34:0)
[21:47:22.022] Timer tick, asking Buildbucket for the build status
[21:47:22.485] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:22.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:35:0) after 1m0s
[21:48:23.106] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:35:0)
[21:48:23.106] Timer tick, asking Buildbucket for the build status
[21:48:23.363] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:23.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:36:0) after 1m0s
[21:49:23.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:36:0)
[21:49:23.577] Timer tick, asking Buildbucket for the build status
[21:49:23.752] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:23.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:37:0) after 1m0s
[21:50:24.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:37:0)
[21:50:24.699] Timer tick, asking Buildbucket for the build status
[21:50:25.414] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:25.414] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:38:0) after 1m0s
[21:51:25.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:38:0)
[21:51:25.416] Timer tick, asking Buildbucket for the build status
[21:51:25.738] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:25.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:39:0) after 1m0s
[21:52:25.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:39:0)
[21:52:25.817] Timer tick, asking Buildbucket for the build status
[21:52:26.801] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:26.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:40:0) after 1m0s
[21:53:26.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:40:0)
[21:53:26.852] Timer tick, asking Buildbucket for the build status
[21:53:27.624] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:27.624] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:41:0) after 1m0s
[21:54:27.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:41:0)
[21:54:27.694] Timer tick, asking Buildbucket for the build status
[21:54:28.930] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:28.930] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:42:0) after 1m0s
[21:55:28.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:42:0)
[21:55:28.954] Timer tick, asking Buildbucket for the build status
[21:55:29.182] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:29.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:43:0) after 1m0s
[21:56:29.341] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:43:0)
[21:56:29.341] Timer tick, asking Buildbucket for the build status
[21:56:29.606] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:29.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:44:0) after 1m0s
[21:57:29.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:44:0)
[21:57:29.695] Timer tick, asking Buildbucket for the build status
[21:57:29.869] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:29.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:45:0) after 1m0s
[21:58:29.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:45:0)
[21:58:29.896] Timer tick, asking Buildbucket for the build status
[21:58:30.140] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:30.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:46:0) after 1m0s
[21:59:30.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:46:0)
[21:59:30.196] Timer tick, asking Buildbucket for the build status
[21:59:30.462] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:30.462] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:47:0) after 1m0s
[22:00:30.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:47:0)
[22:00:30.513] Timer tick, asking Buildbucket for the build status
[22:00:30.904] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:30.904] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:48:0) after 1m0s
[22:01:30.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:48:0)
[22:01:30.950] Timer tick, asking Buildbucket for the build status
[22:01:32.342] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:32.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:49:0) after 1m0s
[22:02:32.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:49:0)
[22:02:32.435] Timer tick, asking Buildbucket for the build status
[22:02:32.715] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:32.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:50:0) after 1m0s
[22:03:32.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:50:0)
[22:03:32.784] Timer tick, asking Buildbucket for the build status
[22:03:33.205] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:33.205] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:51:0) after 1m0s
[22:04:33.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:51:0)
[22:04:33.338] Timer tick, asking Buildbucket for the build status
[22:04:34.222] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:34.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:52:0) after 1m0s
[22:05:34.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:52:0)
[22:05:34.275] Timer tick, asking Buildbucket for the build status
[22:05:34.528] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:34.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:53:0) after 1m0s
[22:06:34.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:53:0)
[22:06:34.621] Timer tick, asking Buildbucket for the build status
[22:06:34.989] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:34.989] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:54:0) after 1m0s
[22:07:35.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:54:0)
[22:07:35.059] Timer tick, asking Buildbucket for the build status
[22:07:35.435] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:35.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:55:0) after 1m0s
[22:08:35.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:55:0)
[22:08:35.606] Timer tick, asking Buildbucket for the build status
[22:08:35.751] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:35.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:56:0) after 1m0s
[22:09:35.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:56:0)
[22:09:35.856] Timer tick, asking Buildbucket for the build status
[22:09:36.126] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:36.126] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:57:0) after 1m0s
[22:10:36.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:57:0)
[22:10:36.168] Timer tick, asking Buildbucket for the build status
[22:10:36.672] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:36.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:58:0) after 1m0s
[22:11:36.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:58:0)
[22:11:36.730] Timer tick, asking Buildbucket for the build status
[22:11:36.941] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:36.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:59:0) after 1m0s
[22:12:37.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:59:0)
[22:12:37.075] Timer tick, asking Buildbucket for the build status
[22:12:38.034] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:38.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:60:0) after 1m0s
[22:13:38.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:60:0)
[22:13:38.093] Timer tick, asking Buildbucket for the build status
[22:13:38.596] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:38.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:61:0) after 1m0s
[22:14:38.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:61:0)
[22:14:38.706] Timer tick, asking Buildbucket for the build status
[22:14:38.974] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:38.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:62:0) after 1m0s
[22:15:38.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:62:0)
[22:15:38.989] Timer tick, asking Buildbucket for the build status
[22:15:39.329] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:39.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:63:0) after 1m0s
[22:16:39.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:63:0)
[22:16:39.351] Timer tick, asking Buildbucket for the build status
[22:16:39.633] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:39.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:64:0) after 1m0s
[22:17:39.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:64:0)
[22:17:39.666] Timer tick, asking Buildbucket for the build status
[22:17:40.012] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:40.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:65:0) after 1m0s
[22:18:40.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:65:0)
[22:18:40.113] Timer tick, asking Buildbucket for the build status
[22:18:41.124] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:41.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:66:0) after 1m0s
[22:19:41.150] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:66:0)
[22:19:41.150] Timer tick, asking Buildbucket for the build status
[22:19:41.570] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:41.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:67:0) after 1m0s
[22:20:41.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:67:0)
[22:20:41.608] Timer tick, asking Buildbucket for the build status
[22:20:41.871] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:41.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:68:0) after 1m0s
[22:21:41.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:68:0)
[22:21:41.915] Timer tick, asking Buildbucket for the build status
[22:21:42.132] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:42.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:69:0) after 1m0s
[22:22:42.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:69:0)
[22:22:42.159] Timer tick, asking Buildbucket for the build status
[22:22:42.504] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:42.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:70:0) after 1m0s
[22:23:43.654] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:70:0)
[22:23:43.654] Timer tick, asking Buildbucket for the build status
[22:23:43.808] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:43.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:71:0) after 1m0s
[22:24:44.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:71:0)
[22:24:44.281] Timer tick, asking Buildbucket for the build status
[22:24:44.669] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:44.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:72:0) after 1m0s
[22:25:45.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:72:0)
[22:25:45.388] Timer tick, asking Buildbucket for the build status
[22:25:45.694] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:45.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:73:0) after 1m0s
[22:26:45.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:73:0)
[22:26:45.944] Timer tick, asking Buildbucket for the build status
[22:26:46.296] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:46.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:74:0) after 1m0s
[22:27:46.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:74:0)
[22:27:46.449] Timer tick, asking Buildbucket for the build status
[22:27:48.718] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:48.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:75:0) after 1m0s
[22:28:48.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:75:0)
[22:28:48.766] Timer tick, asking Buildbucket for the build status
[22:28:48.980] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:48.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:76:0) after 1m0s
[22:29:49.034] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:76:0)
[22:29:49.034] Timer tick, asking Buildbucket for the build status
[22:29:49.310] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:49.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:77:0) after 1m0s
[22:30:49.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:77:0)
[22:30:49.677] Timer tick, asking Buildbucket for the build status
[22:30:50.390] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:50.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:78:0) after 1m0s
[22:31:51.461] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:78:0)
[22:31:51.461] Timer tick, asking Buildbucket for the build status
[22:31:52.142] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:52.142] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:79:0) after 1m0s
[22:32:52.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:79:0)
[22:32:52.549] Timer tick, asking Buildbucket for the build status
[22:32:57.146] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:57.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:80:0) after 1m0s
[22:33:57.279] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:80:0)
[22:33:57.279] Timer tick, asking Buildbucket for the build status
[22:33:59.278] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:59.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:81:0) after 1m0s
[22:34:59.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:81:0)
[22:34:59.937] Timer tick, asking Buildbucket for the build status
[22:35:00.436] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:00.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:82:0) after 1m0s
[22:36:00.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:82:0)
[22:36:00.736] Timer tick, asking Buildbucket for the build status
[22:36:01.092] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:01.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:83:0) after 1m0s
[22:37:01.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:83:0)
[22:37:01.304] Timer tick, asking Buildbucket for the build status
[22:37:02.015] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:02.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:84:0) after 1m0s
[22:38:02.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:84:0)
[22:38:02.390] Timer tick, asking Buildbucket for the build status
[22:38:02.675] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:02.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:85:0) after 1m0s
[22:39:02.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:85:0)
[22:39:02.964] Timer tick, asking Buildbucket for the build status
[22:39:03.243] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:03.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:86:0) after 1m0s
[22:40:03.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:86:0)
[22:40:03.352] Timer tick, asking Buildbucket for the build status
[22:40:03.972] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:03.972] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:87:0) after 1m0s
[22:41:04.140] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:87:0)
[22:41:04.140] Timer tick, asking Buildbucket for the build status
[22:41:04.950] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:04.950] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:88:0) after 1m0s
[22:42:05.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:88:0)
[22:42:05.093] Timer tick, asking Buildbucket for the build status
[22:42:05.255] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:05.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:89:0) after 1m0s
[22:43:05.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:89:0)
[22:43:05.333] Timer tick, asking Buildbucket for the build status
[22:43:05.596] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:05.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:90:0) after 1m0s
[22:44:05.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:90:0)
[22:44:05.678] Timer tick, asking Buildbucket for the build status
[22:44:05.947] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:05.947] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:91:0) after 1m0s
[22:45:06.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:91:0)
[22:45:06.086] Timer tick, asking Buildbucket for the build status
[22:45:07.491] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:07.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:92:0) after 1m0s
[22:46:07.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:92:0)
[22:46:07.589] Timer tick, asking Buildbucket for the build status
[22:46:08.881] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:08.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:93:0) after 1m0s
[22:47:08.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:93:0)
[22:47:08.986] Timer tick, asking Buildbucket for the build status
[22:47:09.908] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:09.908] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:94:0) after 1m0s
[22:48:10.072] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:94:0)
[22:48:10.072] Timer tick, asking Buildbucket for the build status
[22:48:11.211] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:11.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:95:0) after 1m0s
[22:49:11.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:95:0)
[22:49:11.285] Timer tick, asking Buildbucket for the build status
[22:49:11.468] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:11.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:96:0) after 1m0s
[22:50:11.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:96:0)
[22:50:11.493] Timer tick, asking Buildbucket for the build status
[22:50:11.914] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:11.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:97:0) after 1m0s
[22:51:11.976] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:97:0)
[22:51:11.976] Timer tick, asking Buildbucket for the build status
[22:51:13.016] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:13.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:98:0) after 1m0s
[22:52:13.130] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:98:0)
[22:52:13.130] Timer tick, asking Buildbucket for the build status
[22:52:13.770] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:13.770] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:99:0) after 1m0s
[22:53:13.842] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:99:0)
[22:53:13.842] Timer tick, asking Buildbucket for the build status
[22:53:14.777] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:14.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:100:0) after 1m0s
[22:54:14.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:100:0)
[22:54:14.854] Timer tick, asking Buildbucket for the build status
[22:54:15.044] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:15.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:101:0) after 1m0s
[22:55:15.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:101:0)
[22:55:15.090] Timer tick, asking Buildbucket for the build status
[22:55:15.363] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:15.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:102:0) after 1m0s
[22:56:15.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:102:0)
[22:56:15.453] Timer tick, asking Buildbucket for the build status
[22:56:16.658] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:16.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:103:0) after 1m0s
[22:57:16.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:103:0)
[22:57:16.658] Timer tick, asking Buildbucket for the build status
[22:57:16.872] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:16.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:104:0) after 1m0s
[22:58:16.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:104:0)
[22:58:16.951] Timer tick, asking Buildbucket for the build status
[22:58:17.164] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:17.165] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:105:0) after 1m0s
[22:59:17.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:105:0)
[22:59:17.228] Timer tick, asking Buildbucket for the build status
[22:59:17.451] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:17.451] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:106:0) after 1m0s
[23:00:17.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:106:0)
[23:00:17.513] Timer tick, asking Buildbucket for the build status
[23:00:17.949] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:17.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:107:0) after 1m0s
[23:01:17.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:107:0)
[23:01:17.977] Timer tick, asking Buildbucket for the build status
[23:01:19.337] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:19.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:108:0) after 1m0s
[23:02:19.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:108:0)
[23:02:19.372] Timer tick, asking Buildbucket for the build status
[23:02:19.512] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:109:0) after 1m0s
[23:03:19.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:109:0)
[23:03:19.507] Timer tick, asking Buildbucket for the build status
[23:03:19.703] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:19.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:110:0) after 1m0s
[23:04:19.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:110:0)
[23:04:19.739] Timer tick, asking Buildbucket for the build status
[23:04:20.612] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:20.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:111:0) after 1m0s
[23:05:20.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:111:0)
[23:05:20.658] Timer tick, asking Buildbucket for the build status
[23:05:21.378] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:21.378] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:112:0) after 1m0s
[23:06:21.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:112:0)
[23:06:21.408] Timer tick, asking Buildbucket for the build status
[23:06:22.075] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:22.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:113:0) after 1m0s
[23:07:22.174] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:113:0)
[23:07:22.174] Timer tick, asking Buildbucket for the build status
[23:07:22.419] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:22.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:114:0) after 1m0s
[23:08:22.484] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:114:0)
[23:08:22.484] Timer tick, asking Buildbucket for the build status
[23:08:22.783] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:22.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:115:0) after 1m0s
[23:09:22.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:115:0)
[23:09:22.866] Timer tick, asking Buildbucket for the build status
[23:09:23.145] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:23.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:116:0) after 1m0s
[23:10:23.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:116:0)
[23:10:23.208] Timer tick, asking Buildbucket for the build status
[23:10:23.421] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:23.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:117:0) after 1m0s
[23:11:23.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:117:0)
[23:11:23.497] Timer tick, asking Buildbucket for the build status
[23:11:23.843] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:23.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:118:0) after 1m0s
[23:12:23.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:118:0)
[23:12:23.879] Timer tick, asking Buildbucket for the build status
[23:12:24.121] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:24.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:119:0) after 1m0s
[23:13:24.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:119:0)
[23:13:24.579] Timer tick, asking Buildbucket for the build status
[23:13:24.768] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:24.768] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:120:0) after 1m0s
[23:14:25.010] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:120:0)
[23:14:25.010] Timer tick, asking Buildbucket for the build status
[23:14:25.472] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:25.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:121:0) after 1m0s
[23:15:25.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:121:0)
[23:15:25.580] Timer tick, asking Buildbucket for the build status
[23:15:25.821] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:25.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:122:0) after 1m0s
[23:16:26.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:122:0)
[23:16:26.022] Timer tick, asking Buildbucket for the build status
[23:16:26.267] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:26.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:123:0) after 1m0s
[23:17:26.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:123:0)
[23:17:26.381] Timer tick, asking Buildbucket for the build status
[23:17:26.561] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:26.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:124:0) after 1m0s
[23:18:26.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:124:0)
[23:18:26.839] Timer tick, asking Buildbucket for the build status
[23:18:27.310] Build 8894243635019626224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:27.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9059673697040603120:125:0) after 1m0s
[23:19:11.835] Received PubSub notification, asking Buildbucket for the build status
[23:19:12.117] Build 8894243635019626224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:19:12.117] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576192750494089",
"created_by": "project:chromium",
"created_ts": "1576185303630943",
"id": "8894243635019626224",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"da3dfd0675d74d114764cb0b84a937e883e376ff\"}}",
"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-41-gull\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26047, \"got_angle_revision\": \"0bf3c4b585afa0e7849df8efa38e464140da6a3e\", \"got_dawn_revision\": \"69cdaf94dfb127fadc354883d423b63b4e4c3cb1\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"da3dfd0675d74d114764cb0b84a937e883e376ff\", \"got_revision_cp\": \"refs/heads/master@{#724330}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"07958d452f93b6513ebf5cbae64a1325c1755dbf\", \"got_v8_revision\": \"724fd9f1ece40deb98f111c77029733c8f735d8a\", \"got_v8_revision_cp\": \"refs/heads/8.1.27@{#1}\", \"got_webrtc_revision\": \"26fe811623627e1089a8df2c86a89dda2cd9d338\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30068}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"da3dfd0675d74d114764cb0b84a937e883e376ff\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_016577e073ce9abf0fa10d80f88bc2caf8f81662b409bd6e59fa52089e44a3df_v2\", \"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_93a7e775fd8f3ff9ef99e2aeb686615c0006e7587b0f2c5be32706e8df4f86a4_v2\", \"builder_9b311965bcdd39b39aa4e18428ed38a374d2d5d9f2ab24593845b266390676f3_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-xenial-us-central1-b-8-41-gull\"], \"image\": [\"chrome-xenial-19120800-09d8782d9a1\"], \"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\": [\"4713-a14a20b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576185602670293",
"status": "COMPLETED",
"status_changed_ts": "1576192751391133",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26047",
"builder:Deterministic Linux",
"buildset:commit/git/da3dfd0675d74d114764cb0b84a937e883e376ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/da3dfd0675d74d114764cb0b84a937e883e376ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059673697040603120",
"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/8894243635019626224/+/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:4914c8b5bfddd910",
"user_agent:luci-scheduler"
],
"updated_ts": "1576192751394974",
"url": "https://ci.chromium.org/b/8894243635019626224",
"utcnow_ts": "1576192752104919"
}
}
[23:19:12.117] Invocation finished in 2h4m9.798165048s with status SUCCEEDED