[16:43:38.297] New invocation is queued and will start shortly
[16:43:39.505] Starting the invocation (attempt 1)
[16:43:39.627] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:43:39.627] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:43:39.627] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9047913166467443328",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"54aa10adac7129ee33ca0bc6e44d329ea655a477\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9047913166467443328",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/54aa10adac7129ee33ca0bc6e44d329ea655a477",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54aa10adac7129ee33ca0bc6e44d329ea655a477",
"gitiles_ref:refs/heads/master"
]
}
[16:43:41.962] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1587401019773495",
"id": "8882483104249218800",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"54aa10adac7129ee33ca0bc6e44d329ea655a477\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1587401020500306",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27613",
"builder:Deterministic Linux",
"buildset:commit/git/54aa10adac7129ee33ca0bc6e44d329ea655a477",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54aa10adac7129ee33ca0bc6e44d329ea655a477",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9047913166467443328",
"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/8882483104249218800/+/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": "1587401020500478",
"url": "https://ci.chromium.org/b/8882483104249218800",
"utcnow_ts": "1587401021947601"
}
}
[16:43:41.962] Task URL: https://ci.chromium.org/b/8882483104249218800
[16:43:41.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:2:0) after 1m0s
[16:43:51.394] Received PubSub notification, asking Buildbucket for the build status
[16:43:51.479] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:41.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:2:0)
[16:44:41.984] Timer tick, asking Buildbucket for the build status
[16:44:42.327] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:42.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:4:0) after 1m0s
[16:45:42.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:4:0)
[16:45:42.331] Timer tick, asking Buildbucket for the build status
[16:45:43.794] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:43.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:5:0) after 1m0s
[16:46:43.891] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:5:0)
[16:46:43.891] Timer tick, asking Buildbucket for the build status
[16:46:46.816] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:46.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:6:0) after 1m0s
[16:47:46.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:6:0)
[16:47:46.871] Timer tick, asking Buildbucket for the build status
[16:47:47.228] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:47.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:7:0) after 1m0s
[16:48:47.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:7:0)
[16:48:47.352] Timer tick, asking Buildbucket for the build status
[16:48:47.840] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:47.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:8:0) after 1m0s
[16:49:48.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:8:0)
[16:49:48.031] Timer tick, asking Buildbucket for the build status
[16:49:48.184] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:48.185] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:9:0) after 1m0s
[16:50:48.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:9:0)
[16:50:48.207] Timer tick, asking Buildbucket for the build status
[16:50:48.419] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:48.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:10:0) after 1m0s
[16:51:48.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:10:0)
[16:51:48.509] Timer tick, asking Buildbucket for the build status
[16:51:48.853] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:48.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:11:0) after 1m0s
[16:52:48.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:11:0)
[16:52:48.880] Timer tick, asking Buildbucket for the build status
[16:52:50.342] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:50.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:12:0) after 1m0s
[16:53:50.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:12:0)
[16:53:50.528] Timer tick, asking Buildbucket for the build status
[16:53:54.035] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:54.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:13:0) after 1m0s
[16:54:54.120] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:13:0)
[16:54:54.120] Timer tick, asking Buildbucket for the build status
[16:54:55.339] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:55.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:14:0) after 1m0s
[16:55:55.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:14:0)
[16:55:55.522] Timer tick, asking Buildbucket for the build status
[16:55:56.027] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:56.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:15:0) after 1m0s
[16:56:56.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:15:0)
[16:56:56.128] Timer tick, asking Buildbucket for the build status
[16:56:56.961] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:56.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:16:0) after 1m0s
[16:57:57.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:16:0)
[16:57:57.488] Timer tick, asking Buildbucket for the build status
[16:57:57.766] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:57.766] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:17:0) after 1m0s
[16:58:57.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:17:0)
[16:58:57.813] Timer tick, asking Buildbucket for the build status
[16:59:00.336] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:00.336] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:18:0) after 1m0s
[17:00:01.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:18:0)
[17:00:01.192] Timer tick, asking Buildbucket for the build status
[17:00:01.563] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:01.563] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:19:0) after 1m0s
[17:01:01.703] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:19:0)
[17:01:01.703] Timer tick, asking Buildbucket for the build status
[17:01:02.856] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:02.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:20:0) after 1m0s
[17:02:02.927] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:20:0)
[17:02:02.927] Timer tick, asking Buildbucket for the build status
[17:02:03.149] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:03.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:21:0) after 1m0s
[17:03:03.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:21:0)
[17:03:03.213] Timer tick, asking Buildbucket for the build status
[17:03:03.854] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:03.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:22:0) after 1m0s
[17:04:03.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:22:0)
[17:04:03.896] Timer tick, asking Buildbucket for the build status
[17:04:04.956] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:04.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:23:0) after 1m0s
[17:05:04.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:23:0)
[17:05:04.977] Timer tick, asking Buildbucket for the build status
[17:05:05.227] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:05.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:24:0) after 1m0s
[17:06:05.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:24:0)
[17:06:05.256] Timer tick, asking Buildbucket for the build status
[17:06:05.948] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:05.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:25:0) after 1m0s
[17:07:05.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:25:0)
[17:07:05.967] Timer tick, asking Buildbucket for the build status
[17:07:06.215] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:06.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:26:0) after 1m0s
[17:08:06.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:26:0)
[17:08:06.324] Timer tick, asking Buildbucket for the build status
[17:08:07.303] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:07.303] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:27:0) after 1m0s
[17:09:07.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:27:0)
[17:09:07.326] Timer tick, asking Buildbucket for the build status
[17:09:07.738] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:07.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:28:0) after 1m0s
[17:10:07.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:28:0)
[17:10:07.769] Timer tick, asking Buildbucket for the build status
[17:10:08.211] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:08.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:29:0) after 1m0s
[17:11:08.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:29:0)
[17:11:08.240] Timer tick, asking Buildbucket for the build status
[17:11:08.443] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:08.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:30:0) after 1m0s
[17:12:08.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:30:0)
[17:12:08.497] Timer tick, asking Buildbucket for the build status
[17:12:08.565] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:08.565] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:31:0) after 1m0s
[17:13:08.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:31:0)
[17:13:08.612] Timer tick, asking Buildbucket for the build status
[17:13:08.916] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:08.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:32:0) after 1m0s
[17:14:09.396] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:32:0)
[17:14:09.396] Timer tick, asking Buildbucket for the build status
[17:14:09.572] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:09.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:33:0) after 1m0s
[17:15:09.828] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:33:0)
[17:15:09.829] Timer tick, asking Buildbucket for the build status
[17:15:11.966] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:11.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:34:0) after 1m0s
[17:16:11.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:34:0)
[17:16:11.988] Timer tick, asking Buildbucket for the build status
[17:16:13.603] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:13.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:35:0) after 1m0s
[17:17:13.684] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:35:0)
[17:17:13.684] Timer tick, asking Buildbucket for the build status
[17:17:14.103] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:14.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:36:0) after 1m0s
[17:18:14.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:36:0)
[17:18:14.131] Timer tick, asking Buildbucket for the build status
[17:18:14.945] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:14.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:37:0) after 1m0s
[17:19:15.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:37:0)
[17:19:15.058] Timer tick, asking Buildbucket for the build status
[17:19:15.143] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:15.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:38:0) after 1m0s
[17:20:15.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:38:0)
[17:20:15.206] Timer tick, asking Buildbucket for the build status
[17:20:16.714] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:16.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:39:0) after 1m0s
[17:21:16.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:39:0)
[17:21:16.742] Timer tick, asking Buildbucket for the build status
[17:21:16.952] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:16.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:40:0) after 1m0s
[17:22:16.945] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:40:0)
[17:22:16.945] Timer tick, asking Buildbucket for the build status
[17:22:17.711] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:17.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:41:0) after 1m0s
[17:23:17.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:41:0)
[17:23:17.777] Timer tick, asking Buildbucket for the build status
[17:23:18.204] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:18.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:42:0) after 1m0s
[17:24:18.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:42:0)
[17:24:18.340] Timer tick, asking Buildbucket for the build status
[17:24:18.676] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:18.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:43:0) after 1m0s
[17:25:18.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:43:0)
[17:25:18.689] Timer tick, asking Buildbucket for the build status
[17:25:19.092] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:19.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:44:0) after 1m0s
[17:26:19.120] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:44:0)
[17:26:19.120] Timer tick, asking Buildbucket for the build status
[17:26:19.261] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:19.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:45:0) after 1m0s
[17:27:19.291] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:45:0)
[17:27:19.291] Timer tick, asking Buildbucket for the build status
[17:27:19.512] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:46:0) after 1m0s
[17:28:19.800] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:46:0)
[17:28:19.800] Timer tick, asking Buildbucket for the build status
[17:28:19.999] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:19.999] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:47:0) after 1m0s
[17:29:20.674] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:47:0)
[17:29:20.674] Timer tick, asking Buildbucket for the build status
[17:29:20.788] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:20.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:48:0) after 1m0s
[17:30:21.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:48:0)
[17:30:21.067] Timer tick, asking Buildbucket for the build status
[17:30:22.673] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:22.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:49:0) after 1m0s
[17:31:22.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:49:0)
[17:31:22.895] Timer tick, asking Buildbucket for the build status
[17:31:23.026] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:23.026] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:50:0) after 1m0s
[17:32:23.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:50:0)
[17:32:23.344] Timer tick, asking Buildbucket for the build status
[17:32:23.520] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:51:0) after 1m0s
[17:33:23.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:51:0)
[17:33:23.743] Timer tick, asking Buildbucket for the build status
[17:33:23.916] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:23.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:52:0) after 1m0s
[17:34:24.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:52:0)
[17:34:24.027] Timer tick, asking Buildbucket for the build status
[17:34:24.337] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:24.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:53:0) after 1m0s
[17:35:24.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:53:0)
[17:35:24.512] Timer tick, asking Buildbucket for the build status
[17:35:28.106] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:28.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:54:0) after 1m0s
[17:36:28.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:54:0)
[17:36:28.178] Timer tick, asking Buildbucket for the build status
[17:36:28.886] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:28.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:55:0) after 1m0s
[17:37:28.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:55:0)
[17:37:28.934] Timer tick, asking Buildbucket for the build status
[17:37:29.120] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:29.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:56:0) after 1m0s
[17:38:29.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:56:0)
[17:38:29.273] Timer tick, asking Buildbucket for the build status
[17:38:29.590] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:29.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:57:0) after 1m0s
[17:39:29.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:57:0)
[17:39:29.696] Timer tick, asking Buildbucket for the build status
[17:39:29.812] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:29.812] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:58:0) after 1m0s
[17:40:29.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:58:0)
[17:40:29.904] Timer tick, asking Buildbucket for the build status
[17:40:30.363] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:30.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:59:0) after 1m0s
[17:41:30.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:59:0)
[17:41:30.487] Timer tick, asking Buildbucket for the build status
[17:41:30.765] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:30.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:60:0) after 1m0s
[17:42:30.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:60:0)
[17:42:30.837] Timer tick, asking Buildbucket for the build status
[17:42:31.181] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:31.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:61:0) after 1m0s
[17:43:31.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:61:0)
[17:43:31.251] Timer tick, asking Buildbucket for the build status
[17:43:31.425] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:31.425] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:62:0) after 1m0s
[17:44:31.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:62:0)
[17:44:31.574] Timer tick, asking Buildbucket for the build status
[17:44:31.884] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:31.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:63:0) after 1m0s
[17:45:31.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:63:0)
[17:45:31.954] Timer tick, asking Buildbucket for the build status
[17:45:32.592] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:32.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:64:0) after 1m0s
[17:46:32.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:64:0)
[17:46:32.788] Timer tick, asking Buildbucket for the build status
[17:46:33.434] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:33.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:65:0) after 1m0s
[17:47:33.673] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:65:0)
[17:47:33.673] Timer tick, asking Buildbucket for the build status
[17:47:33.861] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:33.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:66:0) after 1m0s
[17:48:33.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:66:0)
[17:48:33.996] Timer tick, asking Buildbucket for the build status
[17:48:34.321] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:34.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:67:0) after 1m0s
[17:49:34.424] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:67:0)
[17:49:34.424] Timer tick, asking Buildbucket for the build status
[17:49:34.665] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:34.665] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:68:0) after 1m0s
[17:50:34.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:68:0)
[17:50:34.719] Timer tick, asking Buildbucket for the build status
[17:50:35.129] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:35.129] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:69:0) after 1m0s
[17:51:35.175] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:69:0)
[17:51:35.175] Timer tick, asking Buildbucket for the build status
[17:51:35.478] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:35.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:70:0) after 1m0s
[17:52:35.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:70:0)
[17:52:35.536] Timer tick, asking Buildbucket for the build status
[17:52:35.897] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:35.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:71:0) after 1m0s
[17:53:36.061] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:71:0)
[17:53:36.061] Timer tick, asking Buildbucket for the build status
[17:53:36.233] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:36.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:72:0) after 1m0s
[17:54:36.289] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:72:0)
[17:54:36.289] Timer tick, asking Buildbucket for the build status
[17:54:36.422] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:36.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:73:0) after 1m0s
[17:55:36.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:73:0)
[17:55:36.522] Timer tick, asking Buildbucket for the build status
[17:55:43.501] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:43.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:74:0) after 1m0s
[17:56:43.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:74:0)
[17:56:43.765] Timer tick, asking Buildbucket for the build status
[17:56:43.940] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:43.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:75:0) after 1m0s
[17:57:44.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:75:0)
[17:57:44.055] Timer tick, asking Buildbucket for the build status
[17:57:44.532] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:44.532] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:76:0) after 1m0s
[17:58:44.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:76:0)
[17:58:44.570] Timer tick, asking Buildbucket for the build status
[17:58:44.687] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:44.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:77:0) after 1m0s
[17:59:44.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:77:0)
[17:59:44.859] Timer tick, asking Buildbucket for the build status
[17:59:45.115] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:45.115] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:78:0) after 1m0s
[18:00:45.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:78:0)
[18:00:45.218] Timer tick, asking Buildbucket for the build status
[18:00:45.421] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:45.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:79:0) after 1m0s
[18:01:45.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:79:0)
[18:01:45.723] Timer tick, asking Buildbucket for the build status
[18:01:45.876] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:45.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:80:0) after 1m0s
[18:02:46.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:80:0)
[18:02:46.134] Timer tick, asking Buildbucket for the build status
[18:02:46.340] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:46.340] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:81:0) after 1m0s
[18:03:46.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:81:0)
[18:03:46.321] Timer tick, asking Buildbucket for the build status
[18:03:46.500] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:46.500] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:82:0) after 1m0s
[18:04:46.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:82:0)
[18:04:46.983] Timer tick, asking Buildbucket for the build status
[18:04:47.383] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:47.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:83:0) after 1m0s
[18:05:47.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:83:0)
[18:05:47.513] Timer tick, asking Buildbucket for the build status
[18:05:47.604] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:47.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:84:0) after 1m0s
[18:06:47.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:84:0)
[18:06:47.656] Timer tick, asking Buildbucket for the build status
[18:06:47.859] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:47.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:85:0) after 1m0s
[18:07:48.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:85:0)
[18:07:48.027] Timer tick, asking Buildbucket for the build status
[18:07:48.472] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:48.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:86:0) after 1m0s
[18:08:48.614] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:86:0)
[18:08:48.614] Timer tick, asking Buildbucket for the build status
[18:08:48.866] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:48.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:87:0) after 1m0s
[18:09:49.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:87:0)
[18:09:49.011] Timer tick, asking Buildbucket for the build status
[18:09:49.237] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:49.237] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:88:0) after 1m0s
[18:10:49.484] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:88:0)
[18:10:49.484] Timer tick, asking Buildbucket for the build status
[18:10:49.652] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:49.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:89:0) after 1m0s
[18:11:49.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:89:0)
[18:11:49.742] Timer tick, asking Buildbucket for the build status
[18:11:49.893] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:49.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:90:0) after 1m0s
[18:12:49.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:90:0)
[18:12:49.908] Timer tick, asking Buildbucket for the build status
[18:12:50.105] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:50.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:91:0) after 1m0s
[18:13:50.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:91:0)
[18:13:50.135] Timer tick, asking Buildbucket for the build status
[18:13:50.296] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:50.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:92:0) after 1m0s
[18:14:50.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:92:0)
[18:14:50.312] Timer tick, asking Buildbucket for the build status
[18:14:50.611] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:50.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:93:0) after 1m0s
[18:15:50.624] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:93:0)
[18:15:50.624] Timer tick, asking Buildbucket for the build status
[18:15:50.963] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:50.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:94:0) after 1m0s
[18:16:51.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:94:0)
[18:16:51.052] Timer tick, asking Buildbucket for the build status
[18:16:51.275] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:51.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:95:0) after 1m0s
[18:17:51.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:95:0)
[18:17:51.334] Timer tick, asking Buildbucket for the build status
[18:17:51.698] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:51.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:96:0) after 1m0s
[18:18:51.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:96:0)
[18:18:51.755] Timer tick, asking Buildbucket for the build status
[18:18:51.865] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:51.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:97:0) after 1m0s
[18:19:51.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:97:0)
[18:19:51.932] Timer tick, asking Buildbucket for the build status
[18:19:52.206] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:52.206] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:98:0) after 1m0s
[18:20:52.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:98:0)
[18:20:52.247] Timer tick, asking Buildbucket for the build status
[18:20:52.603] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:52.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:99:0) after 1m0s
[18:21:52.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:99:0)
[18:21:52.667] Timer tick, asking Buildbucket for the build status
[18:21:52.765] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:52.766] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:100:0) after 1m0s
[18:22:52.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:100:0)
[18:22:52.922] Timer tick, asking Buildbucket for the build status
[18:22:53.250] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:53.250] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:101:0) after 1m0s
[18:23:53.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:101:0)
[18:23:53.356] Timer tick, asking Buildbucket for the build status
[18:23:53.427] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:53.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:102:0) after 1m0s
[18:24:53.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:102:0)
[18:24:53.554] Timer tick, asking Buildbucket for the build status
[18:24:53.777] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:53.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:103:0) after 1m0s
[18:25:53.945] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:103:0)
[18:25:53.945] Timer tick, asking Buildbucket for the build status
[18:25:54.177] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:54.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:104:0) after 1m0s
[18:26:54.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:104:0)
[18:26:54.271] Timer tick, asking Buildbucket for the build status
[18:26:54.583] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:54.583] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:105:0) after 1m0s
[18:27:54.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:105:0)
[18:27:54.666] Timer tick, asking Buildbucket for the build status
[18:27:54.782] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:54.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:106:0) after 1m0s
[18:28:54.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:106:0)
[18:28:54.857] Timer tick, asking Buildbucket for the build status
[18:28:55.033] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:55.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:107:0) after 1m0s
[18:29:55.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:107:0)
[18:29:55.273] Timer tick, asking Buildbucket for the build status
[18:29:55.732] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:55.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:108:0) after 1m0s
[18:30:55.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:108:0)
[18:30:55.740] Timer tick, asking Buildbucket for the build status
[18:30:56.809] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:56.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:109:0) after 1m0s
[18:31:56.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:109:0)
[18:31:56.862] Timer tick, asking Buildbucket for the build status
[18:31:56.962] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:110:0) after 1m0s
[18:32:57.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:110:0)
[18:32:57.104] Timer tick, asking Buildbucket for the build status
[18:32:57.263] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:57.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:111:0) after 1m0s
[18:33:57.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:111:0)
[18:33:57.564] Timer tick, asking Buildbucket for the build status
[18:33:59.780] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:59.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:112:0) after 1m0s
[18:35:00.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:112:0)
[18:35:00.105] Timer tick, asking Buildbucket for the build status
[18:35:00.289] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:00.289] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:113:0) after 1m0s
[18:36:00.400] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:113:0)
[18:36:00.400] Timer tick, asking Buildbucket for the build status
[18:36:00.654] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:00.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:114:0) after 1m0s
[18:37:01.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:114:0)
[18:37:01.706] Timer tick, asking Buildbucket for the build status
[18:37:01.801] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:01.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:115:0) after 1m0s
[18:38:01.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:115:0)
[18:38:01.911] Timer tick, asking Buildbucket for the build status
[18:38:03.763] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:03.763] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:116:0) after 1m0s
[18:39:03.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:116:0)
[18:39:03.825] Timer tick, asking Buildbucket for the build status
[18:39:04.053] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:04.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:117:0) after 1m0s
[18:40:04.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:117:0)
[18:40:04.181] Timer tick, asking Buildbucket for the build status
[18:40:04.428] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:04.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:118:0) after 1m0s
[18:41:04.541] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:118:0)
[18:41:04.541] Timer tick, asking Buildbucket for the build status
[18:41:06.741] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:06.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:119:0) after 1m0s
[18:42:06.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:119:0)
[18:42:06.799] Timer tick, asking Buildbucket for the build status
[18:42:06.954] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:06.954] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:120:0) after 1m0s
[18:43:07.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:120:0)
[18:43:07.015] Timer tick, asking Buildbucket for the build status
[18:43:07.269] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:07.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:121:0) after 1m0s
[18:44:09.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:121:0)
[18:44:09.142] Timer tick, asking Buildbucket for the build status
[18:44:09.883] Build 8882483104249218800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:09.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9047913166467443328:122:0) after 1m0s
[18:44:20.971] Received PubSub notification, asking Buildbucket for the build status
[18:44:21.062] Build 8882483104249218800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:44:21.062] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1587408259859977",
"created_by": "project:chromium",
"created_ts": "1587401019773495",
"id": "8882483104249218800",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"54aa10adac7129ee33ca0bc6e44d329ea655a477\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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-east1-d-8-14-ruze\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27613, \"got_angle_revision\": \"8c693ae8890f46548002a71469c4d9941d561d0e\", \"got_dawn_revision\": \"0ff7ed41ecc5ad70b0c16844fdfced62b0b324b8\", \"got_nacl_revision\": \"d304d90ecc17351ce0fdab3e7452052a469c0976\", \"got_revision\": \"54aa10adac7129ee33ca0bc6e44d329ea655a477\", \"got_revision_cp\": \"refs/heads/master@{#760531}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"068611f07d28255b3efc56df506eabfb049d9411\", \"got_v8_revision\": \"7a9eedf847ddf71516a55c7bc2887cd05e7a88bd\", \"got_v8_revision_cp\": \"refs/heads/8.4.138@{#1}\", \"got_webrtc_revision\": \"dc4f75f7eed26fff21d475ddacaba073eab3c8a0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31110}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"54aa10adac7129ee33ca0bc6e44d329ea655a477\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_bee64b857be6df8b7c1ab34ae7b2c6eab296c35495667b8b8424b2083d103b1e_v2\", \"builder_d43c00ce4b27811359debb63d8f38011e50f8d93e88333ece12438bef3102857_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-14-ruze\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"4997-2128d8d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1587401030329693",
"status": "COMPLETED",
"status_changed_ts": "1587408260334165",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27613",
"builder:Deterministic Linux",
"buildset:commit/git/54aa10adac7129ee33ca0bc6e44d329ea655a477",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54aa10adac7129ee33ca0bc6e44d329ea655a477",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9047913166467443328",
"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/8882483104249218800/+/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:4bb14af2e40f1b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1587408260340426",
"url": "https://ci.chromium.org/b/8882483104249218800",
"utcnow_ts": "1587408261052986"
}
}
[18:44:21.062] Invocation finished in 2h0m42.787696705s with status SUCCEEDED