[13:06:24.836] New invocation is queued and will start shortly
[13:06:26.725] Starting the invocation (attempt 1)
[13:06:26.842] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:06:26.843] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:06:26.843] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9043215790789841536",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cc0cd8441ae665a0a0279b8fc6036d990c543908\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9043215790789841536",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/cc0cd8441ae665a0a0279b8fc6036d990c543908",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc0cd8441ae665a0a0279b8fc6036d990c543908",
"gitiles_ref:refs/heads/master"
]
}
[13:06:29.773] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1591880787004955",
"id": "8877785727844728080",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc0cd8441ae665a0a0279b8fc6036d990c543908\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1591880789516976",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28167",
"builder:Deterministic Linux",
"buildset:commit/git/cc0cd8441ae665a0a0279b8fc6036d990c543908",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc0cd8441ae665a0a0279b8fc6036d990c543908",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043215790789841536",
"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/8877785727844728080/+/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": "1591880789517182",
"url": "https://ci.chromium.org/b/8877785727844728080",
"utcnow_ts": "1591880789754992"
}
}
[13:06:29.773] Task URL: https://ci.chromium.org/b/8877785727844728080
[13:06:29.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:2:0) after 1m0s
[13:06:40.661] Received PubSub notification, asking Buildbucket for the build status
[13:06:42.216] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:29.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:2:0)
[13:07:29.844] Timer tick, asking Buildbucket for the build status
[13:07:30.084] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:30.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:4:0) after 1m0s
[13:08:30.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:4:0)
[13:08:30.193] Timer tick, asking Buildbucket for the build status
[13:08:30.301] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:30.301] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:5:0) after 1m0s
[13:09:30.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:5:0)
[13:09:30.722] Timer tick, asking Buildbucket for the build status
[13:09:31.943] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:31.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:6:0) after 1m0s
[13:10:32.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:6:0)
[13:10:32.102] Timer tick, asking Buildbucket for the build status
[13:10:32.210] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:32.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:7:0) after 1m0s
[13:11:32.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:7:0)
[13:11:32.330] Timer tick, asking Buildbucket for the build status
[13:11:35.951] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:35.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:8:0) after 1m0s
[13:12:35.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:8:0)
[13:12:35.971] Timer tick, asking Buildbucket for the build status
[13:12:36.112] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:36.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:9:0) after 1m0s
[13:13:36.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:9:0)
[13:13:36.145] Timer tick, asking Buildbucket for the build status
[13:13:36.294] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:36.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:10:0) after 1m0s
[13:14:36.480] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:10:0)
[13:14:36.480] Timer tick, asking Buildbucket for the build status
[13:14:36.953] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:36.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:11:0) after 1m0s
[13:15:37.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:11:0)
[13:15:37.097] Timer tick, asking Buildbucket for the build status
[13:15:37.247] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:37.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:12:0) after 1m0s
[13:16:37.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:12:0)
[13:16:37.267] Timer tick, asking Buildbucket for the build status
[13:16:37.635] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:37.635] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:13:0) after 1m0s
[13:17:37.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:13:0)
[13:17:37.643] Timer tick, asking Buildbucket for the build status
[13:17:37.762] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:37.762] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:14:0) after 1m0s
[13:18:37.909] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:14:0)
[13:18:37.909] Timer tick, asking Buildbucket for the build status
[13:18:39.603] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:39.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:15:0) after 1m0s
[13:19:39.640] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:15:0)
[13:19:39.640] Timer tick, asking Buildbucket for the build status
[13:19:39.802] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:39.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:16:0) after 1m0s
[13:20:39.938] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:16:0)
[13:20:39.938] Timer tick, asking Buildbucket for the build status
[13:20:40.298] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:40.298] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:17:0) after 1m0s
[13:21:40.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:17:0)
[13:21:40.364] Timer tick, asking Buildbucket for the build status
[13:21:42.881] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:42.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:18:0) after 1m0s
[13:22:43.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:18:0)
[13:22:43.027] Timer tick, asking Buildbucket for the build status
[13:22:43.388] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:43.388] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:19:0) after 1m0s
[13:23:43.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:19:0)
[13:23:43.408] Timer tick, asking Buildbucket for the build status
[13:23:43.619] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:43.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:20:0) after 1m0s
[13:24:43.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:20:0)
[13:24:43.644] Timer tick, asking Buildbucket for the build status
[13:24:44.006] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:44.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:21:0) after 1m0s
[13:25:43.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:21:0)
[13:25:43.989] Timer tick, asking Buildbucket for the build status
[13:25:44.124] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:44.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:22:0) after 1m0s
[13:26:44.209] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:22:0)
[13:26:44.209] Timer tick, asking Buildbucket for the build status
[13:26:45.374] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:45.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:23:0) after 1m0s
[13:27:45.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:23:0)
[13:27:45.373] Timer tick, asking Buildbucket for the build status
[13:27:45.523] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:45.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:24:0) after 1m0s
[13:28:45.618] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:24:0)
[13:28:45.618] Timer tick, asking Buildbucket for the build status
[13:28:45.840] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:45.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:25:0) after 1m0s
[13:29:45.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:25:0)
[13:29:45.886] Timer tick, asking Buildbucket for the build status
[13:29:46.052] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:46.052] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:26:0) after 1m0s
[13:30:46.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:26:0)
[13:30:46.112] Timer tick, asking Buildbucket for the build status
[13:30:46.396] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:46.396] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:27:0) after 1m0s
[13:31:46.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:27:0)
[13:31:46.473] Timer tick, asking Buildbucket for the build status
[13:31:49.215] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:49.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:28:0) after 1m0s
[13:32:49.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:28:0)
[13:32:49.245] Timer tick, asking Buildbucket for the build status
[13:32:49.444] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:49.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:29:0) after 1m0s
[13:33:49.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:29:0)
[13:33:49.535] Timer tick, asking Buildbucket for the build status
[13:33:50.049] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:50.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:30:0) after 1m0s
[13:34:50.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:30:0)
[13:34:50.193] Timer tick, asking Buildbucket for the build status
[13:34:50.366] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:50.366] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:31:0) after 1m0s
[13:35:50.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:31:0)
[13:35:50.404] Timer tick, asking Buildbucket for the build status
[13:35:50.551] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:50.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:32:0) after 1m0s
[13:36:50.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:32:0)
[13:36:50.658] Timer tick, asking Buildbucket for the build status
[13:36:50.874] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:50.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:33:0) after 1m0s
[13:37:50.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:33:0)
[13:37:50.958] Timer tick, asking Buildbucket for the build status
[13:37:51.125] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:51.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:34:0) after 1m0s
[13:38:51.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:34:0)
[13:38:51.247] Timer tick, asking Buildbucket for the build status
[13:38:51.775] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:51.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:35:0) after 1m0s
[13:39:51.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:35:0)
[13:39:51.833] Timer tick, asking Buildbucket for the build status
[13:39:52.154] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:52.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:36:0) after 1m0s
[13:40:52.175] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:36:0)
[13:40:52.175] Timer tick, asking Buildbucket for the build status
[13:40:52.706] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:52.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:37:0) after 1m0s
[13:41:52.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:37:0)
[13:41:52.798] Timer tick, asking Buildbucket for the build status
[13:41:53.011] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:53.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:38:0) after 1m0s
[13:42:53.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:38:0)
[13:42:53.040] Timer tick, asking Buildbucket for the build status
[13:42:53.445] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:53.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:39:0) after 1m0s
[13:43:53.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:39:0)
[13:43:53.512] Timer tick, asking Buildbucket for the build status
[13:43:53.741] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:53.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:40:0) after 1m0s
[13:44:53.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:40:0)
[13:44:53.749] Timer tick, asking Buildbucket for the build status
[13:44:54.135] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:54.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:41:0) after 1m0s
[13:45:54.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:41:0)
[13:45:54.159] Timer tick, asking Buildbucket for the build status
[13:45:54.393] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:54.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:42:0) after 1m0s
[13:46:54.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:42:0)
[13:46:54.477] Timer tick, asking Buildbucket for the build status
[13:46:55.285] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:55.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:43:0) after 1m0s
[13:47:55.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:43:0)
[13:47:55.388] Timer tick, asking Buildbucket for the build status
[13:47:55.518] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:55.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:44:0) after 1m0s
[13:48:55.635] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:44:0)
[13:48:55.635] Timer tick, asking Buildbucket for the build status
[13:48:55.752] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:55.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:45:0) after 1m0s
[13:49:55.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:45:0)
[13:49:55.922] Timer tick, asking Buildbucket for the build status
[13:49:56.067] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:56.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:46:0) after 1m0s
[13:50:56.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:46:0)
[13:50:56.128] Timer tick, asking Buildbucket for the build status
[13:50:56.384] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:56.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:47:0) after 1m0s
[13:51:56.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:47:0)
[13:51:56.432] Timer tick, asking Buildbucket for the build status
[13:51:56.837] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:56.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:48:0) after 1m0s
[13:52:56.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:48:0)
[13:52:56.888] Timer tick, asking Buildbucket for the build status
[13:52:57.137] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:57.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:49:0) after 1m0s
[13:53:57.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:49:0)
[13:53:57.280] Timer tick, asking Buildbucket for the build status
[13:53:57.406] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:57.406] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:50:0) after 1m0s
[13:54:57.613] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:50:0)
[13:54:57.613] Timer tick, asking Buildbucket for the build status
[13:54:57.802] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:57.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:51:0) after 1m0s
[13:55:57.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:51:0)
[13:55:57.973] Timer tick, asking Buildbucket for the build status
[13:55:58.076] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:58.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:52:0) after 1m0s
[13:56:58.100] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:52:0)
[13:56:58.100] Timer tick, asking Buildbucket for the build status
[13:56:58.338] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:58.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:53:0) after 1m0s
[13:57:58.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:53:0)
[13:57:58.453] Timer tick, asking Buildbucket for the build status
[13:57:58.668] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:58.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:54:0) after 1m0s
[13:58:58.681] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:54:0)
[13:58:58.681] Timer tick, asking Buildbucket for the build status
[13:58:58.843] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:58.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:55:0) after 1m0s
[13:59:58.883] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:55:0)
[13:59:58.883] Timer tick, asking Buildbucket for the build status
[13:59:59.074] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:59.074] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:56:0) after 1m0s
[14:00:59.119] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:56:0)
[14:00:59.119] Timer tick, asking Buildbucket for the build status
[14:00:59.257] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:59.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:57:0) after 1m0s
[14:01:59.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:57:0)
[14:01:59.293] Timer tick, asking Buildbucket for the build status
[14:01:59.431] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:59.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:58:0) after 1m0s
[14:02:59.499] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:58:0)
[14:02:59.499] Timer tick, asking Buildbucket for the build status
[14:03:00.444] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:00.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:59:0) after 1m0s
[14:04:01.085] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:59:0)
[14:04:01.085] Timer tick, asking Buildbucket for the build status
[14:04:01.269] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:01.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:60:0) after 1m0s
[14:05:01.387] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:60:0)
[14:05:01.387] Timer tick, asking Buildbucket for the build status
[14:05:01.552] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:01.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:61:0) after 1m0s
[14:06:02.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:61:0)
[14:06:02.666] Timer tick, asking Buildbucket for the build status
[14:06:02.871] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:02.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:62:0) after 1m0s
[14:07:02.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:62:0)
[14:07:02.910] Timer tick, asking Buildbucket for the build status
[14:07:03.087] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:03.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:63:0) after 1m0s
[14:08:03.109] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:63:0)
[14:08:03.109] Timer tick, asking Buildbucket for the build status
[14:08:03.511] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:03.511] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:64:0) after 1m0s
[14:09:03.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:64:0)
[14:09:03.532] Timer tick, asking Buildbucket for the build status
[14:09:04.006] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:04.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:65:0) after 1m0s
[14:10:04.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:65:0)
[14:10:04.137] Timer tick, asking Buildbucket for the build status
[14:10:04.416] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:04.416] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:66:0) after 1m0s
[14:11:04.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:66:0)
[14:11:04.429] Timer tick, asking Buildbucket for the build status
[14:11:04.951] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:04.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:67:0) after 1m0s
[14:12:05.017] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:67:0)
[14:12:05.017] Timer tick, asking Buildbucket for the build status
[14:12:05.234] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:05.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:68:0) after 1m0s
[14:13:05.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:68:0)
[14:13:05.288] Timer tick, asking Buildbucket for the build status
[14:13:05.398] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:05.398] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:69:0) after 1m0s
[14:14:05.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:69:0)
[14:14:05.462] Timer tick, asking Buildbucket for the build status
[14:14:06.002] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:06.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:70:0) after 1m0s
[14:15:06.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:70:0)
[14:15:06.094] Timer tick, asking Buildbucket for the build status
[14:15:06.249] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:06.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:71:0) after 1m0s
[14:16:06.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:71:0)
[14:16:06.314] Timer tick, asking Buildbucket for the build status
[14:16:06.434] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:06.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:72:0) after 1m0s
[14:17:06.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:72:0)
[14:17:06.454] Timer tick, asking Buildbucket for the build status
[14:17:06.792] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:06.792] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:73:0) after 1m0s
[14:18:06.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:73:0)
[14:18:06.895] Timer tick, asking Buildbucket for the build status
[14:18:08.852] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:08.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:74:0) after 1m0s
[14:19:09.035] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:74:0)
[14:19:09.035] Timer tick, asking Buildbucket for the build status
[14:19:09.207] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:09.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:75:0) after 1m0s
[14:20:09.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:75:0)
[14:20:09.286] Timer tick, asking Buildbucket for the build status
[14:20:09.398] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:09.398] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:76:0) after 1m0s
[14:21:09.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:76:0)
[14:21:09.449] Timer tick, asking Buildbucket for the build status
[14:21:09.863] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:09.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:77:0) after 1m0s
[14:22:10.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:77:0)
[14:22:10.009] Timer tick, asking Buildbucket for the build status
[14:22:10.259] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:10.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:78:0) after 1m0s
[14:23:10.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:78:0)
[14:23:10.299] Timer tick, asking Buildbucket for the build status
[14:23:10.454] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:10.454] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:79:0) after 1m0s
[14:24:10.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:79:0)
[14:24:10.589] Timer tick, asking Buildbucket for the build status
[14:24:10.922] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:10.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:80:0) after 1m0s
[14:25:10.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:80:0)
[14:25:10.970] Timer tick, asking Buildbucket for the build status
[14:25:11.182] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:11.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:81:0) after 1m0s
[14:26:11.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:81:0)
[14:26:11.245] Timer tick, asking Buildbucket for the build status
[14:26:11.408] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:11.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:82:0) after 1m0s
[14:27:11.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:82:0)
[14:27:11.557] Timer tick, asking Buildbucket for the build status
[14:27:11.742] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:11.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:83:0) after 1m0s
[14:28:11.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:83:0)
[14:28:11.901] Timer tick, asking Buildbucket for the build status
[14:28:12.039] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:12.039] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:84:0) after 1m0s
[14:29:12.151] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:84:0)
[14:29:12.151] Timer tick, asking Buildbucket for the build status
[14:29:12.322] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:12.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:85:0) after 1m0s
[14:30:12.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:85:0)
[14:30:12.460] Timer tick, asking Buildbucket for the build status
[14:30:12.911] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:12.911] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:86:0) after 1m0s
[14:31:12.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:86:0)
[14:31:12.950] Timer tick, asking Buildbucket for the build status
[14:31:13.112] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:13.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:87:0) after 1m0s
[14:32:13.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:87:0)
[14:32:13.200] Timer tick, asking Buildbucket for the build status
[14:32:13.445] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:13.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:88:0) after 1m0s
[14:33:13.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:88:0)
[14:33:13.504] Timer tick, asking Buildbucket for the build status
[14:33:13.665] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:13.665] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:89:0) after 1m0s
[14:34:13.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:89:0)
[14:34:13.711] Timer tick, asking Buildbucket for the build status
[14:34:14.182] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:14.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:90:0) after 1m0s
[14:35:14.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:90:0)
[14:35:14.251] Timer tick, asking Buildbucket for the build status
[14:35:14.661] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:14.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:91:0) after 1m0s
[14:36:14.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:91:0)
[14:36:14.749] Timer tick, asking Buildbucket for the build status
[14:36:15.035] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:15.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:92:0) after 1m0s
[14:37:15.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:92:0)
[14:37:15.074] Timer tick, asking Buildbucket for the build status
[14:37:15.354] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:15.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:93:0) after 1m0s
[14:38:15.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:93:0)
[14:38:15.430] Timer tick, asking Buildbucket for the build status
[14:38:15.628] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:15.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:94:0) after 1m0s
[14:39:15.633] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:94:0)
[14:39:15.633] Timer tick, asking Buildbucket for the build status
[14:39:15.979] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:15.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:95:0) after 1m0s
[14:40:16.081] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:95:0)
[14:40:16.081] Timer tick, asking Buildbucket for the build status
[14:40:17.013] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:17.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:96:0) after 1m0s
[14:41:17.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:96:0)
[14:41:17.148] Timer tick, asking Buildbucket for the build status
[14:41:17.907] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:17.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:97:0) after 1m0s
[14:42:18.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:97:0)
[14:42:18.087] Timer tick, asking Buildbucket for the build status
[14:42:18.309] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:18.309] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:98:0) after 1m0s
[14:43:18.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:98:0)
[14:43:18.398] Timer tick, asking Buildbucket for the build status
[14:43:18.540] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:18.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:99:0) after 1m0s
[14:44:18.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:99:0)
[14:44:18.699] Timer tick, asking Buildbucket for the build status
[14:44:18.800] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:18.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:100:0) after 1m0s
[14:45:18.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:100:0)
[14:45:18.860] Timer tick, asking Buildbucket for the build status
[14:45:19.123] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:19.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:101:0) after 1m0s
[14:46:19.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:101:0)
[14:46:19.275] Timer tick, asking Buildbucket for the build status
[14:46:19.496] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:19.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:102:0) after 1m0s
[14:47:19.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:102:0)
[14:47:19.527] Timer tick, asking Buildbucket for the build status
[14:47:19.861] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:19.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:103:0) after 1m0s
[14:48:19.981] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:103:0)
[14:48:19.981] Timer tick, asking Buildbucket for the build status
[14:48:20.198] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:20.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:104:0) after 1m0s
[14:49:20.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:104:0)
[14:49:20.295] Timer tick, asking Buildbucket for the build status
[14:49:20.539] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:20.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:105:0) after 1m0s
[14:50:20.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:105:0)
[14:50:20.666] Timer tick, asking Buildbucket for the build status
[14:50:20.812] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:20.812] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:106:0) after 1m0s
[14:51:20.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:106:0)
[14:51:20.910] Timer tick, asking Buildbucket for the build status
[14:51:21.114] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:21.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:107:0) after 1m0s
[14:52:21.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:107:0)
[14:52:21.240] Timer tick, asking Buildbucket for the build status
[14:52:21.427] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:21.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:108:0) after 1m0s
[14:53:21.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:108:0)
[14:53:21.471] Timer tick, asking Buildbucket for the build status
[14:53:21.600] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:21.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:109:0) after 1m0s
[14:54:21.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:109:0)
[14:54:21.665] Timer tick, asking Buildbucket for the build status
[14:54:21.971] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:21.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:110:0) after 1m0s
[14:55:22.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:110:0)
[14:55:22.084] Timer tick, asking Buildbucket for the build status
[14:55:22.200] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:22.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:111:0) after 1m0s
[14:56:22.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:111:0)
[14:56:22.267] Timer tick, asking Buildbucket for the build status
[14:56:22.547] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:22.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:112:0) after 1m0s
[14:57:22.636] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:112:0)
[14:57:22.636] Timer tick, asking Buildbucket for the build status
[14:57:22.742] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:22.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:113:0) after 1m0s
[14:58:22.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:113:0)
[14:58:22.821] Timer tick, asking Buildbucket for the build status
[14:58:23.255] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:23.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:114:0) after 1m0s
[14:59:23.310] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:114:0)
[14:59:23.310] Timer tick, asking Buildbucket for the build status
[14:59:23.423] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:23.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:115:0) after 1m0s
[15:00:23.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:115:0)
[15:00:23.522] Timer tick, asking Buildbucket for the build status
[15:00:24.798] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:24.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:116:0) after 1m0s
[15:01:24.842] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:116:0)
[15:01:24.843] Timer tick, asking Buildbucket for the build status
[15:01:25.140] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:25.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:117:0) after 1m0s
[15:02:25.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:117:0)
[15:02:25.224] Timer tick, asking Buildbucket for the build status
[15:02:25.444] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:25.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:118:0) after 1m0s
[15:03:25.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:118:0)
[15:03:25.466] Timer tick, asking Buildbucket for the build status
[15:03:25.601] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:25.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:119:0) after 1m0s
[15:04:25.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:119:0)
[15:04:25.729] Timer tick, asking Buildbucket for the build status
[15:04:25.940] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:25.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:120:0) after 1m0s
[15:05:26.021] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:120:0)
[15:05:26.021] Timer tick, asking Buildbucket for the build status
[15:05:26.195] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:26.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:121:0) after 1m0s
[15:06:26.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:121:0)
[15:06:26.230] Timer tick, asking Buildbucket for the build status
[15:06:26.467] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:26.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:122:0) after 1m0s
[15:07:26.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:122:0)
[15:07:26.596] Timer tick, asking Buildbucket for the build status
[15:07:26.816] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:26.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:123:0) after 1m0s
[15:08:26.843] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:123:0)
[15:08:26.843] Timer tick, asking Buildbucket for the build status
[15:08:27.002] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:27.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:124:0) after 1m0s
[15:09:27.042] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:124:0)
[15:09:27.042] Timer tick, asking Buildbucket for the build status
[15:09:27.180] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:27.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:125:0) after 1m0s
[15:10:27.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:125:0)
[15:10:27.242] Timer tick, asking Buildbucket for the build status
[15:10:27.697] Build 8877785727844728080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:27.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9043215790789841536:126:0) after 1m0s
[15:10:37.833] Received PubSub notification, asking Buildbucket for the build status
[15:10:38.027] Build 8877785727844728080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:10:38.027] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1591888236899590",
"created_by": "project:chromium",
"created_ts": "1591880787004955",
"id": "8877785727844728080",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc0cd8441ae665a0a0279b8fc6036d990c543908\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-160-cjfb\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 28167, \"got_angle_revision\": \"cd4bf5e7340e028ae556d309974fd344d222543f\", \"got_dawn_revision\": \"18992f7be95aadcb428fc33cf7092d36755bd8f4\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"cc0cd8441ae665a0a0279b8fc6036d990c543908\", \"got_revision_cp\": \"refs/heads/master@{#777328}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"45510ad8a77862c1ce2e33f0efed41544f5f048b\", \"got_v8_revision\": \"bfc0d2f43a4fa0634b7aaa5d94fb141a64e55978\", \"got_v8_revision_cp\": \"refs/heads/8.5.137@{#1}\", \"got_webrtc_revision\": \"1e79c9ba9c6f1444d8ffee24a882d5ebfdb68595\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31494}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc0cd8441ae665a0a0279b8fc6036d990c543908\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_573c606f18492d6cde6d25a02b12203725732038b1c2909b0b80126d2afb25c2_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-160-cjfb\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5199-07c11c0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1591880798626327",
"status": "COMPLETED",
"status_changed_ts": "1591888237485061",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28167",
"builder:Deterministic Linux",
"buildset:commit/git/cc0cd8441ae665a0a0279b8fc6036d990c543908",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc0cd8441ae665a0a0279b8fc6036d990c543908",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043215790789841536",
"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/8877785727844728080/+/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:4cbc4eb7f4021c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1591888237493564",
"url": "https://ci.chromium.org/b/8877785727844728080",
"utcnow_ts": "1591888238008987"
}
}
[15:10:38.027] Invocation finished in 2h4m13.215117268s with status SUCCEEDED