[20:49:06.781] New invocation is queued and will start shortly
[20:49:07.985] Starting the invocation (attempt 1)
[20:49:08.025] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:49:08.025] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:49:08.025] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9064476967378337088",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0a269f27495a02696e99cd2275d656a2b9a3b31a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9064476967378337088",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/0a269f27495a02696e99cd2275d656a2b9a3b31a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0a269f27495a02696e99cd2275d656a2b9a3b31a",
"gitiles_ref:refs/heads/master"
]
}
[20:49:09.424] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1571604548309637",
"id": "8899046905110787744",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0a269f27495a02696e99cd2275d656a2b9a3b31a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571604549247394",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25362",
"builder:Deterministic Linux",
"buildset:commit/git/0a269f27495a02696e99cd2275d656a2b9a3b31a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0a269f27495a02696e99cd2275d656a2b9a3b31a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064476967378337088",
"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/8899046905110787744/+/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": "1571604549247788",
"url": "https://ci.chromium.org/b/8899046905110787744",
"utcnow_ts": "1571604549416760"
}
}
[20:49:09.424] Task URL: https://ci.chromium.org/b/8899046905110787744
[20:49:09.424] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:2:0) after 1m0s
[20:50:09.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:2:0)
[20:50:09.404] Timer tick, asking Buildbucket for the build status
[20:50:10.149] Build 8899046905110787744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:10.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:3:0) after 1m0s
[20:51:10.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:3:0)
[20:51:10.238] Timer tick, asking Buildbucket for the build status
[20:51:14.710] Build 8899046905110787744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:14.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:4:0) after 1m0s
[20:52:12.223] Received PubSub notification, asking Buildbucket for the build status
[20:52:12.395] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:14.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:4:0)
[20:52:14.728] Timer tick, asking Buildbucket for the build status
[20:52:16.507] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:16.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:6:0) after 1m0s
[20:53:16.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:6:0)
[20:53:16.577] Timer tick, asking Buildbucket for the build status
[20:53:17.596] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:17.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:7:0) after 1m0s
[20:54:17.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:7:0)
[20:54:17.617] Timer tick, asking Buildbucket for the build status
[20:54:18.695] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:18.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:8:0) after 1m0s
[20:55:18.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:8:0)
[20:55:18.837] Timer tick, asking Buildbucket for the build status
[20:55:19.233] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:19.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:9:0) after 1m0s
[20:56:19.310] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:9:0)
[20:56:19.311] Timer tick, asking Buildbucket for the build status
[20:56:20.098] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:20.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:10:0) after 1m0s
[20:57:20.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:10:0)
[20:57:20.177] Timer tick, asking Buildbucket for the build status
[20:57:20.482] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:20.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:11:0) after 1m0s
[20:58:20.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:11:0)
[20:58:20.463] Timer tick, asking Buildbucket for the build status
[20:58:20.869] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:20.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:12:0) after 1m0s
[20:59:20.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:12:0)
[20:59:20.895] Timer tick, asking Buildbucket for the build status
[20:59:21.168] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:21.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:13:0) after 1m0s
[21:00:21.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:13:0)
[21:00:21.208] Timer tick, asking Buildbucket for the build status
[21:00:21.412] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:21.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:14:0) after 1m0s
[21:01:21.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:14:0)
[21:01:21.444] Timer tick, asking Buildbucket for the build status
[21:01:22.034] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:22.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:15:0) after 1m0s
[21:02:22.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:15:0)
[21:02:22.084] Timer tick, asking Buildbucket for the build status
[21:02:22.594] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:22.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:16:0) after 1m0s
[21:03:22.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:16:0)
[21:03:22.677] Timer tick, asking Buildbucket for the build status
[21:03:22.919] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:22.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:17:0) after 1m0s
[21:04:23.023] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:17:0)
[21:04:23.023] Timer tick, asking Buildbucket for the build status
[21:04:26.291] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:26.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:18:0) after 1m0s
[21:05:26.348] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:18:0)
[21:05:26.348] Timer tick, asking Buildbucket for the build status
[21:05:27.809] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:27.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:19:0) after 1m0s
[21:06:27.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:19:0)
[21:06:27.829] Timer tick, asking Buildbucket for the build status
[21:06:28.000] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:28.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:20:0) after 1m0s
[21:07:28.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:20:0)
[21:07:28.194] Timer tick, asking Buildbucket for the build status
[21:07:28.619] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:28.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:21:0) after 1m0s
[21:08:29.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:21:0)
[21:08:29.264] Timer tick, asking Buildbucket for the build status
[21:08:29.788] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:29.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:22:0) after 1m0s
[21:09:29.771] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:22:0)
[21:09:29.771] Timer tick, asking Buildbucket for the build status
[21:09:30.207] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:30.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:23:0) after 1m0s
[21:10:30.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:23:0)
[21:10:30.245] Timer tick, asking Buildbucket for the build status
[21:10:31.265] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:31.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:24:0) after 1m0s
[21:11:31.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:24:0)
[21:11:31.294] Timer tick, asking Buildbucket for the build status
[21:11:31.492] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:31.492] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:25:0) after 1m0s
[21:12:31.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:25:0)
[21:12:31.516] Timer tick, asking Buildbucket for the build status
[21:12:32.609] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:32.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:26:0) after 1m0s
[21:13:32.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:26:0)
[21:13:32.676] Timer tick, asking Buildbucket for the build status
[21:13:32.850] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:32.850] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:27:0) after 1m0s
[21:14:32.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:27:0)
[21:14:32.887] Timer tick, asking Buildbucket for the build status
[21:14:35.037] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:35.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:28:0) after 1m0s
[21:15:35.072] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:28:0)
[21:15:35.072] Timer tick, asking Buildbucket for the build status
[21:15:35.299] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:35.299] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:29:0) after 1m0s
[21:16:35.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:29:0)
[21:16:35.335] Timer tick, asking Buildbucket for the build status
[21:16:38.022] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:38.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:30:0) after 1m0s
[21:17:38.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:30:0)
[21:17:38.062] Timer tick, asking Buildbucket for the build status
[21:17:38.232] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:38.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:31:0) after 1m0s
[21:18:38.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:31:0)
[21:18:38.262] Timer tick, asking Buildbucket for the build status
[21:18:38.403] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:38.403] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:32:0) after 1m0s
[21:19:38.481] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:32:0)
[21:19:38.481] Timer tick, asking Buildbucket for the build status
[21:19:39.129] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:39.129] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:33:0) after 1m0s
[21:20:39.223] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:33:0)
[21:20:39.223] Timer tick, asking Buildbucket for the build status
[21:20:39.957] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:39.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:34:0) after 1m0s
[21:21:39.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:34:0)
[21:21:39.980] Timer tick, asking Buildbucket for the build status
[21:21:40.221] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:40.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:35:0) after 1m0s
[21:22:40.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:35:0)
[21:22:40.246] Timer tick, asking Buildbucket for the build status
[21:22:43.712] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:43.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:36:0) after 1m0s
[21:23:43.796] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:36:0)
[21:23:43.796] Timer tick, asking Buildbucket for the build status
[21:23:45.570] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:45.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:37:0) after 1m0s
[21:24:45.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:37:0)
[21:24:45.596] Timer tick, asking Buildbucket for the build status
[21:24:47.429] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:47.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:38:0) after 1m0s
[21:25:47.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:38:0)
[21:25:47.509] Timer tick, asking Buildbucket for the build status
[21:25:47.789] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:47.790] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:39:0) after 1m0s
[21:26:47.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:39:0)
[21:26:47.855] Timer tick, asking Buildbucket for the build status
[21:26:48.109] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:48.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:40:0) after 1m0s
[21:27:48.191] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:40:0)
[21:27:48.191] Timer tick, asking Buildbucket for the build status
[21:27:48.382] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:48.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:41:0) after 1m0s
[21:28:48.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:41:0)
[21:28:48.407] Timer tick, asking Buildbucket for the build status
[21:28:48.579] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:48.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:42:0) after 1m0s
[21:29:48.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:42:0)
[21:29:48.606] Timer tick, asking Buildbucket for the build status
[21:29:48.936] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:48.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:43:0) after 1m0s
[21:30:48.960] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:43:0)
[21:30:48.960] Timer tick, asking Buildbucket for the build status
[21:30:49.255] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:49.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:44:0) after 1m0s
[21:31:49.279] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:44:0)
[21:31:49.279] Timer tick, asking Buildbucket for the build status
[21:31:50.002] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:50.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:45:0) after 1m0s
[21:32:50.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:45:0)
[21:32:50.048] Timer tick, asking Buildbucket for the build status
[21:32:52.402] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:52.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:46:0) after 1m0s
[21:33:52.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:46:0)
[21:33:52.431] Timer tick, asking Buildbucket for the build status
[21:33:52.956] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:52.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:47:0) after 1m0s
[21:34:53.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:47:0)
[21:34:53.043] Timer tick, asking Buildbucket for the build status
[21:34:53.734] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:53.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:48:0) after 1m0s
[21:35:53.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:48:0)
[21:35:53.792] Timer tick, asking Buildbucket for the build status
[21:35:54.321] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:54.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:49:0) after 1m0s
[21:36:54.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:49:0)
[21:36:54.378] Timer tick, asking Buildbucket for the build status
[21:36:55.443] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:55.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:50:0) after 1m0s
[21:37:55.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:50:0)
[21:37:55.466] Timer tick, asking Buildbucket for the build status
[21:37:55.782] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:55.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:51:0) after 1m0s
[21:38:55.834] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:51:0)
[21:38:55.834] Timer tick, asking Buildbucket for the build status
[21:38:56.568] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:56.568] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:52:0) after 1m0s
[21:39:56.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:52:0)
[21:39:56.611] Timer tick, asking Buildbucket for the build status
[21:39:58.894] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:58.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:53:0) after 1m0s
[21:40:58.931] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:53:0)
[21:40:58.931] Timer tick, asking Buildbucket for the build status
[21:40:59.608] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:59.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:54:0) after 1m0s
[21:41:59.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:54:0)
[21:41:59.647] Timer tick, asking Buildbucket for the build status
[21:41:59.882] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:59.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:55:0) after 1m0s
[21:43:00.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:55:0)
[21:43:00.005] Timer tick, asking Buildbucket for the build status
[21:43:00.805] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:00.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:56:0) after 1m0s
[21:44:00.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:56:0)
[21:44:00.887] Timer tick, asking Buildbucket for the build status
[21:44:01.075] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:01.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:57:0) after 1m0s
[21:45:01.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:57:0)
[21:45:01.138] Timer tick, asking Buildbucket for the build status
[21:45:01.334] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:01.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:58:0) after 1m0s
[21:46:01.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:58:0)
[21:46:01.379] Timer tick, asking Buildbucket for the build status
[21:46:02.310] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:02.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:59:0) after 1m0s
[21:47:02.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:59:0)
[21:47:02.338] Timer tick, asking Buildbucket for the build status
[21:47:03.675] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:03.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:60:0) after 1m0s
[21:48:03.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:60:0)
[21:48:03.707] Timer tick, asking Buildbucket for the build status
[21:48:03.858] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:03.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:61:0) after 1m0s
[21:49:03.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:61:0)
[21:49:03.887] Timer tick, asking Buildbucket for the build status
[21:49:04.334] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:04.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:62:0) after 1m0s
[21:50:04.369] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:62:0)
[21:50:04.369] Timer tick, asking Buildbucket for the build status
[21:50:05.630] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:05.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:63:0) after 1m0s
[21:51:05.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:63:0)
[21:51:05.639] Timer tick, asking Buildbucket for the build status
[21:51:05.798] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:05.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:64:0) after 1m0s
[21:52:05.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:64:0)
[21:52:05.820] Timer tick, asking Buildbucket for the build status
[21:52:06.005] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:06.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:65:0) after 1m0s
[21:53:06.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:65:0)
[21:53:06.031] Timer tick, asking Buildbucket for the build status
[21:53:06.176] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:06.176] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:66:0) after 1m0s
[21:54:06.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:66:0)
[21:54:06.202] Timer tick, asking Buildbucket for the build status
[21:54:07.106] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:07.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:67:0) after 1m0s
[21:55:07.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:67:0)
[21:55:07.181] Timer tick, asking Buildbucket for the build status
[21:55:07.778] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:07.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:68:0) after 1m0s
[21:56:07.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:68:0)
[21:56:07.759] Timer tick, asking Buildbucket for the build status
[21:56:07.932] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:07.933] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:69:0) after 1m0s
[21:57:08.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:69:0)
[21:57:08.103] Timer tick, asking Buildbucket for the build status
[21:57:09.612] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:09.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:70:0) after 1m0s
[21:58:09.641] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:70:0)
[21:58:09.641] Timer tick, asking Buildbucket for the build status
[21:58:09.852] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:09.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:71:0) after 1m0s
[21:59:09.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:71:0)
[21:59:09.880] Timer tick, asking Buildbucket for the build status
[21:59:10.593] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:10.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:72:0) after 1m0s
[22:00:10.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:72:0)
[22:00:10.619] Timer tick, asking Buildbucket for the build status
[22:00:10.799] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:10.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:73:0) after 1m0s
[22:01:10.834] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:73:0)
[22:01:10.834] Timer tick, asking Buildbucket for the build status
[22:01:11.326] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:11.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:74:0) after 1m0s
[22:02:11.400] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:74:0)
[22:02:11.400] Timer tick, asking Buildbucket for the build status
[22:02:11.601] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:11.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:75:0) after 1m0s
[22:03:11.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:75:0)
[22:03:11.625] Timer tick, asking Buildbucket for the build status
[22:03:13.132] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:13.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:76:0) after 1m0s
[22:04:13.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:76:0)
[22:04:13.157] Timer tick, asking Buildbucket for the build status
[22:04:13.444] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:13.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:77:0) after 1m0s
[22:05:13.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:77:0)
[22:05:13.536] Timer tick, asking Buildbucket for the build status
[22:05:15.336] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:15.336] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:78:0) after 1m0s
[22:06:15.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:78:0)
[22:06:15.364] Timer tick, asking Buildbucket for the build status
[22:06:17.424] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:17.424] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:79:0) after 1m0s
[22:07:17.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:79:0)
[22:07:17.493] Timer tick, asking Buildbucket for the build status
[22:07:17.709] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:17.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:80:0) after 1m0s
[22:08:17.783] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:80:0)
[22:08:17.783] Timer tick, asking Buildbucket for the build status
[22:08:18.269] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:18.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:81:0) after 1m0s
[22:09:18.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:81:0)
[22:09:18.360] Timer tick, asking Buildbucket for the build status
[22:09:18.548] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:18.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:82:0) after 1m0s
[22:10:18.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:82:0)
[22:10:18.603] Timer tick, asking Buildbucket for the build status
[22:10:18.914] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:18.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:83:0) after 1m0s
[22:11:18.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:83:0)
[22:11:18.943] Timer tick, asking Buildbucket for the build status
[22:11:21.552] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:21.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:84:0) after 1m0s
[22:12:21.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:84:0)
[22:12:21.616] Timer tick, asking Buildbucket for the build status
[22:12:23.936] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:23.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:85:0) after 1m0s
[22:13:24.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:85:0)
[22:13:24.039] Timer tick, asking Buildbucket for the build status
[22:13:24.376] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:24.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:86:0) after 1m0s
[22:14:24.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:86:0)
[22:14:24.390] Timer tick, asking Buildbucket for the build status
[22:14:24.575] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:24.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:87:0) after 1m0s
[22:15:24.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:87:0)
[22:15:24.617] Timer tick, asking Buildbucket for the build status
[22:15:24.914] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:24.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:88:0) after 1m0s
[22:16:24.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:88:0)
[22:16:24.953] Timer tick, asking Buildbucket for the build status
[22:16:25.121] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:25.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:89:0) after 1m0s
[22:17:25.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:89:0)
[22:17:25.155] Timer tick, asking Buildbucket for the build status
[22:17:26.181] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:26.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:90:0) after 1m0s
[22:18:26.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:90:0)
[22:18:26.228] Timer tick, asking Buildbucket for the build status
[22:18:26.435] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:26.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:91:0) after 1m0s
[22:19:26.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:91:0)
[22:19:26.470] Timer tick, asking Buildbucket for the build status
[22:19:26.791] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:26.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:92:0) after 1m0s
[22:20:26.912] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:92:0)
[22:20:26.912] Timer tick, asking Buildbucket for the build status
[22:20:27.893] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:27.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:93:0) after 1m0s
[22:21:27.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:93:0)
[22:21:27.919] Timer tick, asking Buildbucket for the build status
[22:21:28.290] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:28.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:94:0) after 1m0s
[22:22:28.380] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:94:0)
[22:22:28.380] Timer tick, asking Buildbucket for the build status
[22:22:28.543] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:28.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:95:0) after 1m0s
[22:23:28.690] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:95:0)
[22:23:28.690] Timer tick, asking Buildbucket for the build status
[22:23:29.410] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:29.410] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:96:0) after 1m0s
[22:24:29.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:96:0)
[22:24:29.452] Timer tick, asking Buildbucket for the build status
[22:24:31.232] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:31.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:97:0) after 1m0s
[22:25:31.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:97:0)
[22:25:31.389] Timer tick, asking Buildbucket for the build status
[22:25:33.231] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:33.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:98:0) after 1m0s
[22:26:33.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:98:0)
[22:26:33.311] Timer tick, asking Buildbucket for the build status
[22:26:36.206] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:36.206] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:99:0) after 1m0s
[22:27:36.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:99:0)
[22:27:36.330] Timer tick, asking Buildbucket for the build status
[22:27:37.043] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:37.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:100:0) after 1m0s
[22:28:37.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:100:0)
[22:28:37.180] Timer tick, asking Buildbucket for the build status
[22:28:37.700] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:37.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:101:0) after 1m0s
[22:29:37.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:101:0)
[22:29:37.731] Timer tick, asking Buildbucket for the build status
[22:29:38.839] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:38.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:102:0) after 1m0s
[22:30:38.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:102:0)
[22:30:38.862] Timer tick, asking Buildbucket for the build status
[22:30:39.045] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:39.045] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:103:0) after 1m0s
[22:31:39.072] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:103:0)
[22:31:39.072] Timer tick, asking Buildbucket for the build status
[22:31:39.506] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:39.506] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:104:0) after 1m0s
[22:32:39.518] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:104:0)
[22:32:39.518] Timer tick, asking Buildbucket for the build status
[22:32:39.823] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:39.823] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:105:0) after 1m0s
[22:33:39.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:105:0)
[22:33:39.854] Timer tick, asking Buildbucket for the build status
[22:33:40.811] Build 8899046905110787744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:40.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9064476967378337088:106:0) after 1m0s
[22:33:56.113] Received PubSub notification, asking Buildbucket for the build status
[22:33:56.259] Build 8899046905110787744: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:33:56.259] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1571610835616034",
"created_by": "project:chromium",
"created_ts": "1571604548309637",
"failure_reason": "BUILD_FAILURE",
"id": "8899046905110787744",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0a269f27495a02696e99cd2275d656a2b9a3b31a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"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-east1-d-8-14-frl2\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 25362, \"got_angle_revision\": \"beacd8c81554346f1ab2d9d84717789b30408fa0\", \"got_dawn_revision\": \"8d000e0cc230663dbeae86f59aaa16fc91b1eac1\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"0a269f27495a02696e99cd2275d656a2b9a3b31a\", \"got_revision_cp\": \"refs/heads/master@{#707685}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"b32cc6513131fb1a4327d7d8a15e533eb20e64b4\", \"got_v8_revision_cp\": \"refs/heads/8.0.3@{#1}\", \"got_webrtc_revision\": \"3663ed3ad67893746efd86267a936a7295031ab1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29548}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0a269f27495a02696e99cd2275d656a2b9a3b31a\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-14-frl2\"], \"image\": [\"chrome-xenial-19100400-6cc5b08ab04\"], \"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\": [\"4542-cd693bf\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"Step('compare_build_artifacts') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571604731252965",
"status": "COMPLETED",
"status_changed_ts": "1571604731634210",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25362",
"builder:Deterministic Linux",
"buildset:commit/git/0a269f27495a02696e99cd2275d656a2b9a3b31a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0a269f27495a02696e99cd2275d656a2b9a3b31a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064476967378337088",
"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/8899046905110787744/+/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:4803bfd824b6c910",
"user_agent:luci-scheduler"
],
"updated_ts": "1571610835692690",
"url": "https://ci.chromium.org/b/8899046905110787744",
"utcnow_ts": "1571610836252187"
}
}
[22:33:56.259] Invocation finished in 1h44m49.495691622s with status FAILED