[12:06:38.539] New invocation is queued and will start shortly
[12:06:39.720] Starting the invocation (attempt 1)
[12:06:39.759] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:06:39.760] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:06:39.760] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062516705137558736",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e2cf3bc09c4db0fcf0654079721e494b9834f309\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9062516705137558736",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/e2cf3bc09c4db0fcf0654079721e494b9834f309",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2cf3bc09c4db0fcf0654079721e494b9834f309",
"gitiles_ref:refs/heads/master"
]
}
[12:06:40.753] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573473999956644",
"id": "8897086642980536320",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e2cf3bc09c4db0fcf0654079721e494b9834f309\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573474000543269",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25648",
"builder:Deterministic Linux",
"buildset:commit/git/e2cf3bc09c4db0fcf0654079721e494b9834f309",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2cf3bc09c4db0fcf0654079721e494b9834f309",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062516705137558736",
"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/8897086642980536320/+/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": "1573474000543409",
"url": "https://ci.chromium.org/b/8897086642980536320",
"utcnow_ts": "1573474000745102"
}
}
[12:06:40.753] Task URL: https://ci.chromium.org/b/8897086642980536320
[12:06:40.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:2:0) after 1m0s
[12:06:45.488] Received PubSub notification, asking Buildbucket for the build status
[12:06:45.714] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:40.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:2:0)
[12:07:40.858] Timer tick, asking Buildbucket for the build status
[12:07:41.091] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:41.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:4:0) after 1m0s
[12:08:41.249] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:4:0)
[12:08:41.249] Timer tick, asking Buildbucket for the build status
[12:08:41.464] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:41.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:5:0) after 1m0s
[12:09:41.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:5:0)
[12:09:41.619] Timer tick, asking Buildbucket for the build status
[12:09:42.964] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:42.964] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:6:0) after 1m0s
[12:10:43.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:6:0)
[12:10:43.290] Timer tick, asking Buildbucket for the build status
[12:10:43.611] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:43.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:7:0) after 1m0s
[12:11:43.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:7:0)
[12:11:43.742] Timer tick, asking Buildbucket for the build status
[12:11:43.951] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:43.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:8:0) after 1m0s
[12:12:44.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:8:0)
[12:12:44.048] Timer tick, asking Buildbucket for the build status
[12:12:48.012] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:48.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:9:0) after 1m0s
[12:13:48.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:9:0)
[12:13:48.097] Timer tick, asking Buildbucket for the build status
[12:13:48.285] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:48.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:10:0) after 1m0s
[12:14:48.423] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:10:0)
[12:14:48.423] Timer tick, asking Buildbucket for the build status
[12:14:48.603] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:48.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:11:0) after 1m0s
[12:15:48.793] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:11:0)
[12:15:48.793] Timer tick, asking Buildbucket for the build status
[12:15:51.458] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:51.458] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:12:0) after 1m0s
[12:16:51.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:12:0)
[12:16:51.526] Timer tick, asking Buildbucket for the build status
[12:16:52.852] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:52.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:13:0) after 1m0s
[12:17:52.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:13:0)
[12:17:52.914] Timer tick, asking Buildbucket for the build status
[12:17:53.757] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:53.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:14:0) after 1m0s
[12:18:53.782] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:14:0)
[12:18:53.782] Timer tick, asking Buildbucket for the build status
[12:18:54.023] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:54.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:15:0) after 1m0s
[12:19:54.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:15:0)
[12:19:54.049] Timer tick, asking Buildbucket for the build status
[12:19:54.256] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:54.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:16:0) after 1m0s
[12:20:54.319] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:16:0)
[12:20:54.319] Timer tick, asking Buildbucket for the build status
[12:20:55.200] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:55.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:17:0) after 1m0s
[12:21:55.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:17:0)
[12:21:55.224] Timer tick, asking Buildbucket for the build status
[12:21:55.374] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:55.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:18:0) after 1m0s
[12:22:55.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:18:0)
[12:22:55.407] Timer tick, asking Buildbucket for the build status
[12:22:55.856] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:55.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:19:0) after 1m0s
[12:23:55.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:19:0)
[12:23:55.904] Timer tick, asking Buildbucket for the build status
[12:23:56.242] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:56.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:20:0) after 1m0s
[12:24:56.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:20:0)
[12:24:56.238] Timer tick, asking Buildbucket for the build status
[12:24:56.455] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:56.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:21:0) after 1m0s
[12:25:56.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:21:0)
[12:25:56.557] Timer tick, asking Buildbucket for the build status
[12:25:57.284] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:57.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:22:0) after 1m0s
[12:26:57.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:22:0)
[12:26:57.358] Timer tick, asking Buildbucket for the build status
[12:26:58.740] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:58.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:23:0) after 1m0s
[12:27:58.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:23:0)
[12:27:58.750] Timer tick, asking Buildbucket for the build status
[12:27:59.063] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:59.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:24:0) after 1m0s
[12:28:59.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:24:0)
[12:28:59.128] Timer tick, asking Buildbucket for the build status
[12:28:59.570] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:59.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:25:0) after 1m0s
[12:29:59.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:25:0)
[12:29:59.596] Timer tick, asking Buildbucket for the build status
[12:29:59.790] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:59.790] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:26:0) after 1m0s
[12:30:59.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:26:0)
[12:30:59.819] Timer tick, asking Buildbucket for the build status
[12:31:00.056] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:00.056] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:27:0) after 1m0s
[12:32:00.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:27:0)
[12:32:00.115] Timer tick, asking Buildbucket for the build status
[12:32:01.464] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:01.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:28:0) after 1m0s
[12:33:01.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:28:0)
[12:33:01.508] Timer tick, asking Buildbucket for the build status
[12:33:01.732] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:01.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:29:0) after 1m0s
[12:34:01.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:29:0)
[12:34:01.804] Timer tick, asking Buildbucket for the build status
[12:34:02.395] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:02.395] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:30:0) after 1m0s
[12:35:02.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:30:0)
[12:35:02.416] Timer tick, asking Buildbucket for the build status
[12:35:02.813] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:02.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:31:0) after 1m0s
[12:36:02.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:31:0)
[12:36:02.856] Timer tick, asking Buildbucket for the build status
[12:36:03.114] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:03.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:32:0) after 1m0s
[12:37:03.147] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:32:0)
[12:37:03.147] Timer tick, asking Buildbucket for the build status
[12:37:03.386] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:03.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:33:0) after 1m0s
[12:38:03.422] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:33:0)
[12:38:03.422] Timer tick, asking Buildbucket for the build status
[12:38:04.059] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:04.059] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:34:0) after 1m0s
[12:39:04.150] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:34:0)
[12:39:04.150] Timer tick, asking Buildbucket for the build status
[12:39:04.547] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:04.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:35:0) after 1m0s
[12:40:04.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:35:0)
[12:40:04.632] Timer tick, asking Buildbucket for the build status
[12:40:05.352] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:05.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:36:0) after 1m0s
[12:41:05.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:36:0)
[12:41:05.555] Timer tick, asking Buildbucket for the build status
[12:41:05.766] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:05.766] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:37:0) after 1m0s
[12:42:05.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:37:0)
[12:42:05.916] Timer tick, asking Buildbucket for the build status
[12:42:06.745] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:06.745] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:38:0) after 1m0s
[12:43:06.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:38:0)
[12:43:06.743] Timer tick, asking Buildbucket for the build status
[12:43:06.998] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:06.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:39:0) after 1m0s
[12:44:07.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:39:0)
[12:44:07.272] Timer tick, asking Buildbucket for the build status
[12:44:07.483] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:07.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:40:0) after 1m0s
[12:45:07.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:40:0)
[12:45:07.557] Timer tick, asking Buildbucket for the build status
[12:45:12.711] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:12.711] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:41:0) after 1m0s
[12:46:12.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:41:0)
[12:46:12.788] Timer tick, asking Buildbucket for the build status
[12:46:13.062] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:13.062] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:42:0) after 1m0s
[12:47:13.114] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:42:0)
[12:47:13.114] Timer tick, asking Buildbucket for the build status
[12:47:13.703] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:13.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:43:0) after 1m0s
[12:48:13.779] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:43:0)
[12:48:13.779] Timer tick, asking Buildbucket for the build status
[12:48:15.447] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:15.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:44:0) after 1m0s
[12:49:15.518] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:44:0)
[12:49:15.518] Timer tick, asking Buildbucket for the build status
[12:49:15.770] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:15.770] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:45:0) after 1m0s
[12:50:15.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:45:0)
[12:50:15.803] Timer tick, asking Buildbucket for the build status
[12:50:16.066] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:16.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:46:0) after 1m0s
[12:51:16.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:46:0)
[12:51:16.076] Timer tick, asking Buildbucket for the build status
[12:51:17.088] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:17.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:47:0) after 1m0s
[12:52:17.322] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:47:0)
[12:52:17.322] Timer tick, asking Buildbucket for the build status
[12:52:17.998] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:17.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:48:0) after 1m0s
[12:53:18.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:48:0)
[12:53:18.044] Timer tick, asking Buildbucket for the build status
[12:53:19.131] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:19.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:49:0) after 1m0s
[12:54:19.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:49:0)
[12:54:19.217] Timer tick, asking Buildbucket for the build status
[12:54:19.870] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:19.870] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:50:0) after 1m0s
[12:55:19.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:50:0)
[12:55:19.855] Timer tick, asking Buildbucket for the build status
[12:55:20.199] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:20.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:51:0) after 1m0s
[12:56:20.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:51:0)
[12:56:20.263] Timer tick, asking Buildbucket for the build status
[12:56:20.694] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:20.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:52:0) after 1m0s
[12:57:20.721] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:52:0)
[12:57:20.721] Timer tick, asking Buildbucket for the build status
[12:57:21.190] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:21.190] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:53:0) after 1m0s
[12:58:21.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:53:0)
[12:58:21.222] Timer tick, asking Buildbucket for the build status
[12:58:21.480] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:21.480] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:54:0) after 1m0s
[12:59:21.560] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:54:0)
[12:59:21.560] Timer tick, asking Buildbucket for the build status
[12:59:21.797] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:21.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:55:0) after 1m0s
[13:00:21.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:55:0)
[13:00:21.813] Timer tick, asking Buildbucket for the build status
[13:00:22.889] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:22.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:56:0) after 1m0s
[13:01:22.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:56:0)
[13:01:22.879] Timer tick, asking Buildbucket for the build status
[13:01:23.147] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:23.147] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:57:0) after 1m0s
[13:02:23.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:57:0)
[13:02:23.194] Timer tick, asking Buildbucket for the build status
[13:02:23.481] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:23.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:58:0) after 1m0s
[13:03:23.614] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:58:0)
[13:03:23.614] Timer tick, asking Buildbucket for the build status
[13:03:24.098] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:24.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:59:0) after 1m0s
[13:04:24.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:59:0)
[13:04:24.200] Timer tick, asking Buildbucket for the build status
[13:04:24.397] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:24.397] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:60:0) after 1m0s
[13:05:24.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:60:0)
[13:05:24.470] Timer tick, asking Buildbucket for the build status
[13:05:24.927] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:24.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:61:0) after 1m0s
[13:06:24.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:61:0)
[13:06:24.920] Timer tick, asking Buildbucket for the build status
[13:06:25.187] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:25.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:62:0) after 1m0s
[13:07:25.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:62:0)
[13:07:25.200] Timer tick, asking Buildbucket for the build status
[13:07:25.471] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:25.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:63:0) after 1m0s
[13:08:25.500] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:63:0)
[13:08:25.500] Timer tick, asking Buildbucket for the build status
[13:08:26.112] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:26.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:64:0) after 1m0s
[13:09:26.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:64:0)
[13:09:26.184] Timer tick, asking Buildbucket for the build status
[13:09:26.490] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:26.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:65:0) after 1m0s
[13:10:26.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:65:0)
[13:10:26.537] Timer tick, asking Buildbucket for the build status
[13:10:27.849] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:27.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:66:0) after 1m0s
[13:11:27.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:66:0)
[13:11:27.977] Timer tick, asking Buildbucket for the build status
[13:11:28.570] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:28.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:67:0) after 1m0s
[13:12:28.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:67:0)
[13:12:28.659] Timer tick, asking Buildbucket for the build status
[13:12:29.032] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:29.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:68:0) after 1m0s
[13:13:30.360] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:68:0)
[13:13:30.361] Timer tick, asking Buildbucket for the build status
[13:13:30.669] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:30.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:69:0) after 1m0s
[13:14:30.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:69:0)
[13:14:30.735] Timer tick, asking Buildbucket for the build status
[13:14:31.501] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:31.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:70:0) after 1m0s
[13:15:31.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:70:0)
[13:15:31.804] Timer tick, asking Buildbucket for the build status
[13:15:32.135] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:32.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:71:0) after 1m0s
[13:16:32.261] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:71:0)
[13:16:32.261] Timer tick, asking Buildbucket for the build status
[13:16:32.441] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:32.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:72:0) after 1m0s
[13:17:32.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:72:0)
[13:17:32.471] Timer tick, asking Buildbucket for the build status
[13:17:32.881] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:32.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:73:0) after 1m0s
[13:18:32.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:73:0)
[13:18:32.924] Timer tick, asking Buildbucket for the build status
[13:18:33.533] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:33.533] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:74:0) after 1m0s
[13:19:33.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:74:0)
[13:19:33.592] Timer tick, asking Buildbucket for the build status
[13:19:33.921] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:33.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:75:0) after 1m0s
[13:20:34.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:75:0)
[13:20:34.045] Timer tick, asking Buildbucket for the build status
[13:20:34.231] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:34.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:76:0) after 1m0s
[13:21:34.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:76:0)
[13:21:34.254] Timer tick, asking Buildbucket for the build status
[13:21:34.660] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:34.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:77:0) after 1m0s
[13:22:34.704] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:77:0)
[13:22:34.704] Timer tick, asking Buildbucket for the build status
[13:22:34.911] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:34.911] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:78:0) after 1m0s
[13:23:35.047] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:78:0)
[13:23:35.047] Timer tick, asking Buildbucket for the build status
[13:23:35.281] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:35.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:79:0) after 1m0s
[13:24:35.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:79:0)
[13:24:35.290] Timer tick, asking Buildbucket for the build status
[13:24:36.042] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:36.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:80:0) after 1m0s
[13:25:36.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:80:0)
[13:25:36.108] Timer tick, asking Buildbucket for the build status
[13:25:36.329] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:36.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:81:0) after 1m0s
[13:26:36.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:81:0)
[13:26:36.389] Timer tick, asking Buildbucket for the build status
[13:26:36.703] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:36.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:82:0) after 1m0s
[13:27:36.805] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:82:0)
[13:27:36.805] Timer tick, asking Buildbucket for the build status
[13:27:38.768] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:38.768] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:83:0) after 1m0s
[13:28:38.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:83:0)
[13:28:38.790] Timer tick, asking Buildbucket for the build status
[13:28:38.957] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:38.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:84:0) after 1m0s
[13:29:38.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:84:0)
[13:29:38.989] Timer tick, asking Buildbucket for the build status
[13:29:39.399] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:39.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:85:0) after 1m0s
[13:30:39.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:85:0)
[13:30:39.462] Timer tick, asking Buildbucket for the build status
[13:30:39.821] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:39.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:86:0) after 1m0s
[13:31:39.849] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:86:0)
[13:31:39.849] Timer tick, asking Buildbucket for the build status
[13:31:40.086] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:40.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:87:0) after 1m0s
[13:32:40.149] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:87:0)
[13:32:40.149] Timer tick, asking Buildbucket for the build status
[13:32:40.936] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:40.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:88:0) after 1m0s
[13:33:40.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:88:0)
[13:33:40.980] Timer tick, asking Buildbucket for the build status
[13:33:41.187] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:41.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:89:0) after 1m0s
[13:34:41.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:89:0)
[13:34:41.219] Timer tick, asking Buildbucket for the build status
[13:34:41.895] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:41.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:90:0) after 1m0s
[13:35:41.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:90:0)
[13:35:41.985] Timer tick, asking Buildbucket for the build status
[13:35:42.201] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:42.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:91:0) after 1m0s
[13:36:42.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:91:0)
[13:36:42.250] Timer tick, asking Buildbucket for the build status
[13:36:45.150] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:45.150] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:92:0) after 1m0s
[13:37:45.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:92:0)
[13:37:45.210] Timer tick, asking Buildbucket for the build status
[13:37:45.596] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:45.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:93:0) after 1m0s
[13:38:45.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:93:0)
[13:38:45.578] Timer tick, asking Buildbucket for the build status
[13:38:45.922] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:45.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:94:0) after 1m0s
[13:39:46.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:94:0)
[13:39:46.157] Timer tick, asking Buildbucket for the build status
[13:39:46.357] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:46.358] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:95:0) after 1m0s
[13:40:46.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:95:0)
[13:40:46.617] Timer tick, asking Buildbucket for the build status
[13:40:46.858] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:46.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:96:0) after 1m0s
[13:41:46.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:96:0)
[13:41:46.894] Timer tick, asking Buildbucket for the build status
[13:41:47.240] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:47.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:97:0) after 1m0s
[13:42:47.301] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:97:0)
[13:42:47.301] Timer tick, asking Buildbucket for the build status
[13:42:47.537] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:47.537] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:98:0) after 1m0s
[13:43:47.600] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:98:0)
[13:43:47.600] Timer tick, asking Buildbucket for the build status
[13:43:48.682] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:48.682] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:99:0) after 1m0s
[13:44:48.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:99:0)
[13:44:48.759] Timer tick, asking Buildbucket for the build status
[13:44:49.007] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:49.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:100:0) after 1m0s
[13:45:49.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:100:0)
[13:45:49.103] Timer tick, asking Buildbucket for the build status
[13:45:49.569] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:49.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:101:0) after 1m0s
[13:46:49.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:101:0)
[13:46:49.755] Timer tick, asking Buildbucket for the build status
[13:46:49.926] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:49.926] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:102:0) after 1m0s
[13:47:50.003] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:102:0)
[13:47:50.003] Timer tick, asking Buildbucket for the build status
[13:47:50.399] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:50.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:103:0) after 1m0s
[13:48:50.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:103:0)
[13:48:50.473] Timer tick, asking Buildbucket for the build status
[13:48:51.360] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:51.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:104:0) after 1m0s
[13:49:51.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:104:0)
[13:49:51.399] Timer tick, asking Buildbucket for the build status
[13:49:51.821] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:51.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:105:0) after 1m0s
[13:50:51.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:105:0)
[13:50:51.833] Timer tick, asking Buildbucket for the build status
[13:50:52.024] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:52.024] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:106:0) after 1m0s
[13:51:52.147] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:106:0)
[13:51:52.147] Timer tick, asking Buildbucket for the build status
[13:51:55.517] Build 8897086642980536320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:55.517] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062516705137558736:107:0) after 1m0s
[13:52:09.942] Received PubSub notification, asking Buildbucket for the build status
[13:52:10.222] Build 8897086642980536320: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:52:10.222] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573480327931808",
"created_by": "project:chromium",
"created_ts": "1573473999956644",
"id": "8897086642980536320",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e2cf3bc09c4db0fcf0654079721e494b9834f309\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-4-4im3\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 25648, \"got_angle_revision\": \"1c7097b69c50eecc7416d6aa52e87cabc25ebf17\", \"got_dawn_revision\": \"3c086a0c2e1dc3e2e14aaa3d78c052c7e07274b4\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"e2cf3bc09c4db0fcf0654079721e494b9834f309\", \"got_revision_cp\": \"refs/heads/master@{#714186}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"31edef751a8d8428db1fc9e0f68c345ab987811f\", \"got_v8_revision\": \"54b9decff6d862f67f07b41d3b1102dfbb4f35d6\", \"got_v8_revision_cp\": \"refs/heads/8.0.215@{#1}\", \"got_webrtc_revision\": \"a4c1aaad8d5fe0d412f08f084b0aa36e01393550\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29750}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e2cf3bc09c4db0fcf0654079721e494b9834f309\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3df726b65531685b338b7c2caf48988c15becc2e6a96e549d7512dce09d4fac6_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_fbb3d50a702ddd064319c35d96f4b89f6e7a29ba4c11145a49be75e11fea82c5_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-4-4im3\"], \"image\": [\"chrome-xenial-19102400-d35fedf5a0d\"], \"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\": [\"4621-f8a5b1c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1573474003819564",
"status": "COMPLETED",
"status_changed_ts": "1573480328339208",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25648",
"builder:Deterministic Linux",
"buildset:commit/git/e2cf3bc09c4db0fcf0654079721e494b9834f309",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2cf3bc09c4db0fcf0654079721e494b9834f309",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062516705137558736",
"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/8897086642980536320/+/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:48732d6796e36810",
"user_agent:luci-scheduler"
],
"updated_ts": "1573480328343782",
"url": "https://ci.chromium.org/b/8897086642980536320",
"utcnow_ts": "1573480330213326"
}
}
[13:52:10.222] Invocation finished in 1h45m31.706985615s with status SUCCEEDED