[04:30:42.245] New invocation is queued and will start shortly
[04:30:43.331] Starting the invocation (attempt 1)
[04:30:43.375] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:30:43.375] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:30:43.375] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9066622253773629456",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"9d51231739f9bf87d3d9829000ea3c6ce115f876\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9066622253773629456",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/9d51231739f9bf87d3d9829000ea3c6ce115f876",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d51231739f9bf87d3d9829000ea3c6ce115f876",
"gitiles_ref:refs/heads/master"
]
}
[04:30:45.227] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1569558643818770",
"id": "8901192191457737664",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9d51231739f9bf87d3d9829000ea3c6ce115f876\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1569558644904336",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24937",
"builder:Deterministic Linux",
"buildset:commit/git/9d51231739f9bf87d3d9829000ea3c6ce115f876",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d51231739f9bf87d3d9829000ea3c6ce115f876",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066622253773629456",
"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/8901192191457737664/+/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": "1569558644904630",
"url": "https://ci.chromium.org/b/8901192191457737664",
"utcnow_ts": "1569558645212576"
}
}
[04:30:45.227] Task URL: https://ci.chromium.org/b/8901192191457737664
[04:30:45.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:2:0) after 1m0s
[04:30:48.820] Received PubSub notification, asking Buildbucket for the build status
[04:30:49.129] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:45.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:2:0)
[04:31:45.398] Timer tick, asking Buildbucket for the build status
[04:31:45.702] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:45.702] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:4:0) after 1m0s
[04:32:45.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:4:0)
[04:32:45.818] Timer tick, asking Buildbucket for the build status
[04:32:46.339] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:46.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:5:0) after 1m0s
[04:33:46.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:5:0)
[04:33:46.858] Timer tick, asking Buildbucket for the build status
[04:33:47.552] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:47.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:6:0) after 1m0s
[04:34:47.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:6:0)
[04:34:47.717] Timer tick, asking Buildbucket for the build status
[04:34:49.047] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:49.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:7:0) after 1m0s
[04:35:49.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:7:0)
[04:35:49.177] Timer tick, asking Buildbucket for the build status
[04:35:50.058] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:50.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:8:0) after 1m0s
[04:36:50.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:8:0)
[04:36:50.364] Timer tick, asking Buildbucket for the build status
[04:36:50.672] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:50.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:9:0) after 1m0s
[04:37:50.772] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:9:0)
[04:37:50.772] Timer tick, asking Buildbucket for the build status
[04:37:53.875] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:53.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:10:0) after 1m0s
[04:38:53.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:10:0)
[04:38:53.874] Timer tick, asking Buildbucket for the build status
[04:38:54.122] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:54.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:11:0) after 1m0s
[04:39:54.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:11:0)
[04:39:54.313] Timer tick, asking Buildbucket for the build status
[04:39:54.748] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:54.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:12:0) after 1m0s
[04:40:54.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:12:0)
[04:40:54.880] Timer tick, asking Buildbucket for the build status
[04:40:55.472] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:55.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:13:0) after 1m0s
[04:41:55.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:13:0)
[04:41:55.574] Timer tick, asking Buildbucket for the build status
[04:41:55.931] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:55.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:14:0) after 1m0s
[04:42:56.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:14:0)
[04:42:56.013] Timer tick, asking Buildbucket for the build status
[04:42:56.868] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:56.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:15:0) after 1m0s
[04:43:56.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:15:0)
[04:43:56.962] Timer tick, asking Buildbucket for the build status
[04:43:57.411] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:57.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:16:0) after 1m0s
[04:44:57.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:16:0)
[04:44:57.574] Timer tick, asking Buildbucket for the build status
[04:44:57.858] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:57.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:17:0) after 1m0s
[04:45:57.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:17:0)
[04:45:57.917] Timer tick, asking Buildbucket for the build status
[04:45:58.307] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:58.307] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:18:0) after 1m0s
[04:46:58.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:18:0)
[04:46:58.327] Timer tick, asking Buildbucket for the build status
[04:46:58.936] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:58.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:19:0) after 1m0s
[04:47:58.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:19:0)
[04:47:58.992] Timer tick, asking Buildbucket for the build status
[04:47:59.212] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:59.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:20:0) after 1m0s
[04:48:59.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:20:0)
[04:48:59.304] Timer tick, asking Buildbucket for the build status
[04:49:01.285] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:01.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:21:0) after 1m0s
[04:50:01.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:21:0)
[04:50:01.284] Timer tick, asking Buildbucket for the build status
[04:50:01.578] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:01.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:22:0) after 1m0s
[04:51:02.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:22:0)
[04:51:02.304] Timer tick, asking Buildbucket for the build status
[04:51:04.059] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:04.060] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:23:0) after 1m0s
[04:52:04.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:23:0)
[04:52:04.146] Timer tick, asking Buildbucket for the build status
[04:52:04.445] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:04.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:24:0) after 1m0s
[04:53:04.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:24:0)
[04:53:04.540] Timer tick, asking Buildbucket for the build status
[04:53:04.932] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:04.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:25:0) after 1m0s
[04:54:05.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:25:0)
[04:54:05.057] Timer tick, asking Buildbucket for the build status
[04:54:05.409] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:05.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:26:0) after 1m0s
[04:55:05.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:26:0)
[04:55:05.458] Timer tick, asking Buildbucket for the build status
[04:55:12.480] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:12.480] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:27:0) after 1m0s
[04:56:12.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:27:0)
[04:56:12.547] Timer tick, asking Buildbucket for the build status
[04:56:13.438] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:13.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:28:0) after 1m0s
[04:57:13.461] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:28:0)
[04:57:13.461] Timer tick, asking Buildbucket for the build status
[04:57:13.730] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:13.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:29:0) after 1m0s
[04:58:13.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:29:0)
[04:58:13.774] Timer tick, asking Buildbucket for the build status
[04:58:14.509] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:14.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:30:0) after 1m0s
[04:59:14.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:30:0)
[04:59:14.570] Timer tick, asking Buildbucket for the build status
[04:59:15.304] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:15.304] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:31:0) after 1m0s
[05:00:15.558] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:31:0)
[05:00:15.558] Timer tick, asking Buildbucket for the build status
[05:00:16.130] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:16.130] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:32:0) after 1m0s
[05:01:16.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:32:0)
[05:01:16.273] Timer tick, asking Buildbucket for the build status
[05:01:17.053] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:17.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:33:0) after 1m0s
[05:02:17.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:33:0)
[05:02:17.103] Timer tick, asking Buildbucket for the build status
[05:02:17.336] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:17.336] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:34:0) after 1m0s
[05:03:17.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:34:0)
[05:03:17.359] Timer tick, asking Buildbucket for the build status
[05:03:18.100] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:18.100] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:35:0) after 1m0s
[05:04:18.255] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:35:0)
[05:04:18.255] Timer tick, asking Buildbucket for the build status
[05:04:18.991] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:18.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:36:0) after 1m0s
[05:05:18.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:36:0)
[05:05:18.993] Timer tick, asking Buildbucket for the build status
[05:05:19.631] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:19.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:37:0) after 1m0s
[05:06:24.079] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:37:0)
[05:06:24.079] Timer tick, asking Buildbucket for the build status
[05:06:24.611] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:24.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:38:0) after 1m0s
[05:07:24.613] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:38:0)
[05:07:24.613] Timer tick, asking Buildbucket for the build status
[05:07:24.869] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:24.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:39:0) after 1m0s
[05:08:24.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:39:0)
[05:08:24.971] Timer tick, asking Buildbucket for the build status
[05:08:25.264] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:25.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:40:0) after 1m0s
[05:09:25.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:40:0)
[05:09:25.300] Timer tick, asking Buildbucket for the build status
[05:09:25.487] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:25.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:41:0) after 1m0s
[05:10:25.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:41:0)
[05:10:25.543] Timer tick, asking Buildbucket for the build status
[05:10:27.983] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:27.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:42:0) after 1m0s
[05:11:28.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:42:0)
[05:11:28.052] Timer tick, asking Buildbucket for the build status
[05:11:28.321] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:28.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:43:0) after 1m0s
[05:12:40.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:43:0)
[05:12:40.586] Timer tick, asking Buildbucket for the build status
[05:12:40.869] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:40.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:44:0) after 1m0s
[05:13:41.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:44:0)
[05:13:41.179] Timer tick, asking Buildbucket for the build status
[05:13:42.903] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:42.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:45:0) after 1m0s
[05:14:43.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:45:0)
[05:14:43.009] Timer tick, asking Buildbucket for the build status
[05:14:43.688] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:43.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:46:0) after 1m0s
[05:15:43.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:46:0)
[05:15:43.844] Timer tick, asking Buildbucket for the build status
[05:15:49.258] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:49.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:47:0) after 1m0s
[05:16:49.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:47:0)
[05:16:49.399] Timer tick, asking Buildbucket for the build status
[05:16:52.083] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:52.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:48:0) after 1m0s
[05:17:52.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:48:0)
[05:17:52.148] Timer tick, asking Buildbucket for the build status
[05:17:52.633] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:52.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:49:0) after 1m0s
[05:18:52.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:49:0)
[05:18:52.735] Timer tick, asking Buildbucket for the build status
[05:18:54.475] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:54.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:50:0) after 1m0s
[05:19:54.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:50:0)
[05:19:54.580] Timer tick, asking Buildbucket for the build status
[05:19:55.847] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:55.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:51:0) after 1m0s
[05:20:55.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:51:0)
[05:20:55.906] Timer tick, asking Buildbucket for the build status
[05:20:56.125] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:56.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:52:0) after 1m0s
[05:21:56.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:52:0)
[05:21:56.293] Timer tick, asking Buildbucket for the build status
[05:21:56.995] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:56.995] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:53:0) after 1m0s
[05:22:57.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:53:0)
[05:22:57.037] Timer tick, asking Buildbucket for the build status
[05:22:57.617] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:57.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:54:0) after 1m0s
[05:23:57.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:54:0)
[05:23:57.754] Timer tick, asking Buildbucket for the build status
[05:23:58.673] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:58.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:55:0) after 1m0s
[05:24:58.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:55:0)
[05:24:58.929] Timer tick, asking Buildbucket for the build status
[05:25:02.850] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:02.850] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:56:0) after 1m0s
[05:26:02.938] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:56:0)
[05:26:02.938] Timer tick, asking Buildbucket for the build status
[05:26:03.286] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:03.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:57:0) after 1m0s
[05:27:03.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:57:0)
[05:27:03.343] Timer tick, asking Buildbucket for the build status
[05:27:06.937] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:06.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:58:0) after 1m0s
[05:28:07.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:58:0)
[05:28:07.161] Timer tick, asking Buildbucket for the build status
[05:28:07.507] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:07.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:59:0) after 1m0s
[05:29:07.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:59:0)
[05:29:07.701] Timer tick, asking Buildbucket for the build status
[05:29:08.560] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:08.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:60:0) after 1m0s
[05:30:08.826] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:60:0)
[05:30:08.826] Timer tick, asking Buildbucket for the build status
[05:30:09.034] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:09.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:61:0) after 1m0s
[05:31:09.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:61:0)
[05:31:09.065] Timer tick, asking Buildbucket for the build status
[05:31:09.848] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:09.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:62:0) after 1m0s
[05:32:09.881] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:62:0)
[05:32:09.881] Timer tick, asking Buildbucket for the build status
[05:32:10.407] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:10.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:63:0) after 1m0s
[05:33:10.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:63:0)
[05:33:10.467] Timer tick, asking Buildbucket for the build status
[05:33:10.962] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:10.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:64:0) after 1m0s
[05:34:10.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:64:0)
[05:34:10.996] Timer tick, asking Buildbucket for the build status
[05:34:11.257] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:11.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:65:0) after 1m0s
[05:35:11.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:65:0)
[05:35:11.344] Timer tick, asking Buildbucket for the build status
[05:35:14.522] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:14.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:66:0) after 1m0s
[05:36:14.681] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:66:0)
[05:36:14.681] Timer tick, asking Buildbucket for the build status
[05:36:15.643] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:15.643] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:67:0) after 1m0s
[05:37:15.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:67:0)
[05:37:15.665] Timer tick, asking Buildbucket for the build status
[05:37:19.238] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:19.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:68:0) after 1m0s
[05:38:19.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:68:0)
[05:38:19.340] Timer tick, asking Buildbucket for the build status
[05:38:19.569] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:19.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:69:0) after 1m0s
[05:39:19.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:69:0)
[05:39:19.668] Timer tick, asking Buildbucket for the build status
[05:39:20.645] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:20.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:70:0) after 1m0s
[05:40:20.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:70:0)
[05:40:20.706] Timer tick, asking Buildbucket for the build status
[05:40:21.325] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:21.325] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:71:0) after 1m0s
[05:41:21.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:71:0)
[05:41:21.432] Timer tick, asking Buildbucket for the build status
[05:41:24.556] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:24.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:72:0) after 1m0s
[05:42:24.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:72:0)
[05:42:24.598] Timer tick, asking Buildbucket for the build status
[05:42:24.751] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:24.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:73:0) after 1m0s
[05:43:24.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:73:0)
[05:43:24.921] Timer tick, asking Buildbucket for the build status
[05:43:25.142] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:25.142] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:74:0) after 1m0s
[05:44:25.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:74:0)
[05:44:25.269] Timer tick, asking Buildbucket for the build status
[05:44:26.822] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:26.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:75:0) after 1m0s
[05:45:26.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:75:0)
[05:45:26.846] Timer tick, asking Buildbucket for the build status
[05:45:27.118] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:27.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:76:0) after 1m0s
[05:46:27.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:76:0)
[05:46:27.232] Timer tick, asking Buildbucket for the build status
[05:46:29.370] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:29.370] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:77:0) after 1m0s
[05:47:29.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:77:0)
[05:47:29.401] Timer tick, asking Buildbucket for the build status
[05:47:30.731] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:30.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:78:0) after 1m0s
[05:48:30.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:78:0)
[05:48:30.860] Timer tick, asking Buildbucket for the build status
[05:48:32.954] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:32.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:79:0) after 1m0s
[05:49:32.981] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:79:0)
[05:49:32.981] Timer tick, asking Buildbucket for the build status
[05:49:33.263] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:33.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:80:0) after 1m0s
[05:50:33.354] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:80:0)
[05:50:33.354] Timer tick, asking Buildbucket for the build status
[05:50:33.834] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:33.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:81:0) after 1m0s
[05:51:33.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:81:0)
[05:51:33.895] Timer tick, asking Buildbucket for the build status
[05:51:34.687] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:34.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:82:0) after 1m0s
[05:52:34.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:82:0)
[05:52:34.745] Timer tick, asking Buildbucket for the build status
[05:52:34.917] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:34.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:83:0) after 1m0s
[05:53:35.023] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:83:0)
[05:53:35.023] Timer tick, asking Buildbucket for the build status
[05:53:35.362] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:35.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:84:0) after 1m0s
[05:54:35.443] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:84:0)
[05:54:35.443] Timer tick, asking Buildbucket for the build status
[05:54:35.839] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:35.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:85:0) after 1m0s
[05:55:36.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:85:0)
[05:55:36.067] Timer tick, asking Buildbucket for the build status
[05:55:36.564] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:36.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:86:0) after 1m0s
[05:56:36.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:86:0)
[05:56:36.639] Timer tick, asking Buildbucket for the build status
[05:56:38.196] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:38.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:87:0) after 1m0s
[05:57:38.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:87:0)
[05:57:38.395] Timer tick, asking Buildbucket for the build status
[05:57:38.790] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:38.790] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:88:0) after 1m0s
[05:58:38.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:88:0)
[05:58:38.835] Timer tick, asking Buildbucket for the build status
[05:58:39.979] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:39.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:89:0) after 1m0s
[05:59:40.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:89:0)
[05:59:40.192] Timer tick, asking Buildbucket for the build status
[05:59:41.053] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:41.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:90:0) after 1m0s
[06:00:41.160] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:90:0)
[06:00:41.160] Timer tick, asking Buildbucket for the build status
[06:00:41.991] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:41.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:91:0) after 1m0s
[06:01:42.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:91:0)
[06:01:42.094] Timer tick, asking Buildbucket for the build status
[06:01:42.520] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:42.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:92:0) after 1m0s
[06:02:43.002] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:92:0)
[06:02:43.002] Timer tick, asking Buildbucket for the build status
[06:02:43.348] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:43.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:93:0) after 1m0s
[06:03:43.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:93:0)
[06:03:43.510] Timer tick, asking Buildbucket for the build status
[06:03:44.158] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:44.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:94:0) after 1m0s
[06:04:44.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:94:0)
[06:04:44.398] Timer tick, asking Buildbucket for the build status
[06:04:44.957] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:44.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:95:0) after 1m0s
[06:05:45.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:95:0)
[06:05:45.256] Timer tick, asking Buildbucket for the build status
[06:05:47.412] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:47.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:96:0) after 1m0s
[06:06:47.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:96:0)
[06:06:47.574] Timer tick, asking Buildbucket for the build status
[06:06:47.975] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:47.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:97:0) after 1m0s
[06:07:48.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:97:0)
[06:07:48.012] Timer tick, asking Buildbucket for the build status
[06:07:48.213] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:48.213] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:98:0) after 1m0s
[06:08:48.319] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:98:0)
[06:08:48.319] Timer tick, asking Buildbucket for the build status
[06:08:50.373] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:50.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:99:0) after 1m0s
[06:09:50.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:99:0)
[06:09:50.462] Timer tick, asking Buildbucket for the build status
[06:09:52.199] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:52.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:100:0) after 1m0s
[06:10:52.316] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:100:0)
[06:10:52.316] Timer tick, asking Buildbucket for the build status
[06:10:55.282] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:55.282] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:101:0) after 1m0s
[06:11:55.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:101:0)
[06:11:55.536] Timer tick, asking Buildbucket for the build status
[06:11:56.232] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:56.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:102:0) after 1m0s
[06:12:56.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:102:0)
[06:12:56.317] Timer tick, asking Buildbucket for the build status
[06:12:58.707] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:58.707] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:103:0) after 1m0s
[06:13:58.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:103:0)
[06:13:58.738] Timer tick, asking Buildbucket for the build status
[06:13:59.891] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:59.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:104:0) after 1m0s
[06:14:59.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:104:0)
[06:14:59.920] Timer tick, asking Buildbucket for the build status
[06:15:00.299] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:00.299] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:105:0) after 1m0s
[06:16:00.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:105:0)
[06:16:00.368] Timer tick, asking Buildbucket for the build status
[06:16:01.741] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:01.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:106:0) after 1m0s
[06:17:01.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:106:0)
[06:17:01.830] Timer tick, asking Buildbucket for the build status
[06:17:03.381] Build 8901192191457737664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:03.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066622253773629456:107:0) after 1m0s
[06:17:49.352] Received PubSub notification, asking Buildbucket for the build status
[06:17:49.613] Build 8901192191457737664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:17:49.613] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1569565068379465",
"created_by": "project:chromium",
"created_ts": "1569558643818770",
"id": "8901192191457737664",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9d51231739f9bf87d3d9829000ea3c6ce115f876\"}}",
"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-136-p7e4\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 24937, \"got_angle_revision\": \"7f506bde16f165f923e9fd7e80c4f8b6314618fd\", \"got_dawn_revision\": \"64f4dd71278a76e1cffb4578e6441a09fd231283\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"9d51231739f9bf87d3d9829000ea3c6ce115f876\", \"got_revision_cp\": \"refs/heads/master@{#700583}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"ed58b8fbcd71e3a2d9af2fb083bd15543e9829c2\", \"got_v8_revision_cp\": \"refs/heads/7.9.150@{#1}\", \"got_webrtc_revision\": \"1903a35e00e89555180b8442c42d3bdbd91565ee\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29328}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9d51231739f9bf87d3d9829000ea3c6ce115f876\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_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-136-p7e4\"], \"image\": [\"chrome-xenial-19090600-ed917d8233f\"], \"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\": [\"4443-3a52fcb\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1569558647189621",
"status": "COMPLETED",
"status_changed_ts": "1569565068780596",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24937",
"builder:Deterministic Linux",
"buildset:commit/git/9d51231739f9bf87d3d9829000ea3c6ce115f876",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d51231739f9bf87d3d9829000ea3c6ce115f876",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066622253773629456",
"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/8901192191457737664/+/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:4789cdd5c7d13b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1569565068785169",
"url": "https://ci.chromium.org/b/8901192191457737664",
"utcnow_ts": "1569565069596213"
}
}
[06:17:49.613] Invocation finished in 1h47m7.386803269s with status SUCCEEDED