[19:01:56.327] New invocation is queued and will start shortly
[19:01:57.568] Starting the invocation (attempt 1)
[19:01:57.640] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:01:57.640] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:01:57.640] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060044458845433232",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"eebed353a806a953f892e3aa57fb44a4f45acc71\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9060044458845433232",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/eebed353a806a953f892e3aa57fb44a4f45acc71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eebed353a806a953f892e3aa57fb44a4f45acc71",
"gitiles_ref:refs/heads/master"
]
}
[19:02:00.757] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575831717875667",
"id": "8894614396555343936",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eebed353a806a953f892e3aa57fb44a4f45acc71\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575831720483081",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26002",
"builder:Deterministic Linux",
"buildset:commit/git/eebed353a806a953f892e3aa57fb44a4f45acc71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eebed353a806a953f892e3aa57fb44a4f45acc71",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060044458845433232",
"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/8894614396555343936/+/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": "1575831720483198",
"url": "https://ci.chromium.org/b/8894614396555343936",
"utcnow_ts": "1575831720725719"
}
}
[19:02:00.757] Task URL: https://ci.chromium.org/b/8894614396555343936
[19:02:00.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:2:0) after 1m0s
[19:03:01.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:2:0)
[19:03:01.457] Timer tick, asking Buildbucket for the build status
[19:03:01.680] Build 8894614396555343936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:01.681] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:3:0) after 1m0s
[19:04:01.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:3:0)
[19:04:01.785] Timer tick, asking Buildbucket for the build status
[19:04:02.011] Build 8894614396555343936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:02.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:4:0) after 1m0s
[19:05:02.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:4:0)
[19:05:02.113] Timer tick, asking Buildbucket for the build status
[19:05:02.895] Build 8894614396555343936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:02.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:5:0) after 1m0s
[19:06:02.972] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:5:0)
[19:06:02.972] Timer tick, asking Buildbucket for the build status
[19:06:03.125] Build 8894614396555343936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:03.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:6:0) after 1m0s
[19:06:06.799] Received PubSub notification, asking Buildbucket for the build status
[19:06:07.085] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:03.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:6:0)
[19:07:03.240] Timer tick, asking Buildbucket for the build status
[19:07:03.568] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:03.568] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:8:0) after 1m0s
[19:08:03.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:8:0)
[19:08:03.701] Timer tick, asking Buildbucket for the build status
[19:08:04.498] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:04.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:9:0) after 1m0s
[19:09:04.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:9:0)
[19:09:04.605] Timer tick, asking Buildbucket for the build status
[19:09:05.248] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:05.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:10:0) after 1m0s
[19:10:05.301] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:10:0)
[19:10:05.301] Timer tick, asking Buildbucket for the build status
[19:10:05.731] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:05.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:11:0) after 1m0s
[19:11:05.764] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:11:0)
[19:11:05.764] Timer tick, asking Buildbucket for the build status
[19:11:05.977] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:05.977] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:12:0) after 1m0s
[19:12:06.163] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:12:0)
[19:12:06.163] Timer tick, asking Buildbucket for the build status
[19:12:06.415] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:06.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:13:0) after 1m0s
[19:13:06.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:13:0)
[19:13:06.495] Timer tick, asking Buildbucket for the build status
[19:13:06.668] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:06.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:14:0) after 1m0s
[19:14:06.720] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:14:0)
[19:14:06.720] Timer tick, asking Buildbucket for the build status
[19:14:06.883] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:06.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:15:0) after 1m0s
[19:15:07.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:15:0)
[19:15:07.196] Timer tick, asking Buildbucket for the build status
[19:15:07.581] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:07.581] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:16:0) after 1m0s
[19:16:07.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:16:0)
[19:16:07.722] Timer tick, asking Buildbucket for the build status
[19:16:07.868] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:07.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:17:0) after 1m0s
[19:17:07.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:17:0)
[19:17:07.989] Timer tick, asking Buildbucket for the build status
[19:17:08.225] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:08.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:18:0) after 1m0s
[19:18:08.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:18:0)
[19:18:08.297] Timer tick, asking Buildbucket for the build status
[19:18:08.512] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:08.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:19:0) after 1m0s
[19:19:08.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:19:0)
[19:19:08.507] Timer tick, asking Buildbucket for the build status
[19:19:08.717] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:08.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:20:0) after 1m0s
[19:20:08.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:20:0)
[19:20:08.871] Timer tick, asking Buildbucket for the build status
[19:20:09.228] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:09.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:21:0) after 1m0s
[19:21:09.261] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:21:0)
[19:21:09.261] Timer tick, asking Buildbucket for the build status
[19:21:09.435] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:09.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:22:0) after 1m0s
[19:22:09.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:22:0)
[19:22:09.477] Timer tick, asking Buildbucket for the build status
[19:22:09.764] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:09.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:23:0) after 1m0s
[19:23:09.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:23:0)
[19:23:09.837] Timer tick, asking Buildbucket for the build status
[19:23:10.021] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:10.021] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:24:0) after 1m0s
[19:24:10.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:24:0)
[19:24:10.065] Timer tick, asking Buildbucket for the build status
[19:24:10.316] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:10.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:25:0) after 1m0s
[19:25:10.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:25:0)
[19:25:10.346] Timer tick, asking Buildbucket for the build status
[19:25:10.545] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:10.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:26:0) after 1m0s
[19:26:10.627] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:26:0)
[19:26:10.627] Timer tick, asking Buildbucket for the build status
[19:26:10.866] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:10.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:27:0) after 1m0s
[19:27:10.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:27:0)
[19:27:10.906] Timer tick, asking Buildbucket for the build status
[19:27:11.532] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:11.532] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:28:0) after 1m0s
[19:28:11.672] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:28:0)
[19:28:11.672] Timer tick, asking Buildbucket for the build status
[19:28:11.852] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:11.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:29:0) after 1m0s
[19:29:11.935] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:29:0)
[19:29:11.935] Timer tick, asking Buildbucket for the build status
[19:29:12.189] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:12.189] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:30:0) after 1m0s
[19:30:12.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:30:0)
[19:30:12.275] Timer tick, asking Buildbucket for the build status
[19:30:12.742] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:12.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:31:0) after 1m0s
[19:31:12.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:31:0)
[19:31:12.809] Timer tick, asking Buildbucket for the build status
[19:31:13.005] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:13.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:32:0) after 1m0s
[19:32:13.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:32:0)
[19:32:13.064] Timer tick, asking Buildbucket for the build status
[19:32:13.247] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:13.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:33:0) after 1m0s
[19:33:13.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:33:0)
[19:33:13.371] Timer tick, asking Buildbucket for the build status
[19:33:13.843] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:13.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:34:0) after 1m0s
[19:34:13.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:34:0)
[19:34:13.956] Timer tick, asking Buildbucket for the build status
[19:34:14.315] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:14.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:35:0) after 1m0s
[19:35:14.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:35:0)
[19:35:14.343] Timer tick, asking Buildbucket for the build status
[19:35:15.100] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:15.100] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:36:0) after 1m0s
[19:36:15.211] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:36:0)
[19:36:15.211] Timer tick, asking Buildbucket for the build status
[19:36:16.111] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:16.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:37:0) after 1m0s
[19:37:16.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:37:0)
[19:37:16.284] Timer tick, asking Buildbucket for the build status
[19:37:16.459] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:16.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:38:0) after 1m0s
[19:38:16.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:38:0)
[19:38:16.489] Timer tick, asking Buildbucket for the build status
[19:38:16.782] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:16.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:39:0) after 1m0s
[19:39:16.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:39:0)
[19:39:16.830] Timer tick, asking Buildbucket for the build status
[19:39:17.355] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:17.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:40:0) after 1m0s
[19:40:17.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:40:0)
[19:40:17.430] Timer tick, asking Buildbucket for the build status
[19:40:17.871] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:17.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:41:0) after 1m0s
[19:41:17.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:41:0)
[19:41:17.879] Timer tick, asking Buildbucket for the build status
[19:41:18.202] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:18.202] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:42:0) after 1m0s
[19:42:18.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:42:0)
[19:42:18.254] Timer tick, asking Buildbucket for the build status
[19:42:18.547] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:18.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:43:0) after 1m0s
[19:43:18.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:43:0)
[19:43:18.583] Timer tick, asking Buildbucket for the build status
[19:43:19.008] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:19.008] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:44:0) after 1m0s
[19:44:19.047] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:44:0)
[19:44:19.047] Timer tick, asking Buildbucket for the build status
[19:44:19.241] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:19.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:45:0) after 1m0s
[19:45:19.243] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:45:0)
[19:45:19.243] Timer tick, asking Buildbucket for the build status
[19:45:19.846] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:19.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:46:0) after 1m0s
[19:46:19.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:46:0)
[19:46:19.875] Timer tick, asking Buildbucket for the build status
[19:46:20.229] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:20.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:47:0) after 1m0s
[19:47:20.318] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:47:0)
[19:47:20.318] Timer tick, asking Buildbucket for the build status
[19:47:20.567] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:20.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:48:0) after 1m0s
[19:48:20.602] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:48:0)
[19:48:20.602] Timer tick, asking Buildbucket for the build status
[19:48:21.098] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:21.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:49:0) after 1m0s
[19:49:21.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:49:0)
[19:49:21.177] Timer tick, asking Buildbucket for the build status
[19:49:21.704] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:21.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:50:0) after 1m0s
[19:50:21.807] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:50:0)
[19:50:21.807] Timer tick, asking Buildbucket for the build status
[19:50:22.108] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:22.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:51:0) after 1m0s
[19:51:22.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:51:0)
[19:51:22.137] Timer tick, asking Buildbucket for the build status
[19:51:22.479] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:22.479] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:52:0) after 1m0s
[19:52:22.708] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:52:0)
[19:52:22.709] Timer tick, asking Buildbucket for the build status
[19:52:22.864] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:22.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:53:0) after 1m0s
[19:53:23.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:53:0)
[19:53:23.062] Timer tick, asking Buildbucket for the build status
[19:53:23.886] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:23.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:54:0) after 1m0s
[19:54:24.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:54:0)
[19:54:24.115] Timer tick, asking Buildbucket for the build status
[19:54:24.984] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:24.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:55:0) after 1m0s
[19:55:25.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:55:0)
[19:55:25.102] Timer tick, asking Buildbucket for the build status
[19:55:25.296] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:25.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:56:0) after 1m0s
[19:56:25.437] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:56:0)
[19:56:25.437] Timer tick, asking Buildbucket for the build status
[19:56:25.811] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:25.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:57:0) after 1m0s
[19:57:25.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:57:0)
[19:57:25.917] Timer tick, asking Buildbucket for the build status
[19:57:26.299] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:26.299] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:58:0) after 1m0s
[19:58:26.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:58:0)
[19:58:26.446] Timer tick, asking Buildbucket for the build status
[19:58:26.695] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:26.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:59:0) after 1m0s
[19:59:26.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:59:0)
[19:59:26.904] Timer tick, asking Buildbucket for the build status
[19:59:27.085] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:27.085] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:60:0) after 1m0s
[20:00:27.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:60:0)
[20:00:27.350] Timer tick, asking Buildbucket for the build status
[20:00:27.556] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:27.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:61:0) after 1m0s
[20:01:27.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:61:0)
[20:01:27.626] Timer tick, asking Buildbucket for the build status
[20:01:27.788] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:27.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:62:0) after 1m0s
[20:02:27.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:62:0)
[20:02:27.821] Timer tick, asking Buildbucket for the build status
[20:02:28.278] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:28.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:63:0) after 1m0s
[20:03:28.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:63:0)
[20:03:28.302] Timer tick, asking Buildbucket for the build status
[20:03:29.291] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:29.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:64:0) after 1m0s
[20:04:29.305] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:64:0)
[20:04:29.305] Timer tick, asking Buildbucket for the build status
[20:04:29.619] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:29.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:65:0) after 1m0s
[20:05:29.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:65:0)
[20:05:29.630] Timer tick, asking Buildbucket for the build status
[20:05:29.924] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:29.924] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:66:0) after 1m0s
[20:06:30.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:66:0)
[20:06:30.071] Timer tick, asking Buildbucket for the build status
[20:06:30.485] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:30.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:67:0) after 1m0s
[20:07:30.652] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:67:0)
[20:07:30.652] Timer tick, asking Buildbucket for the build status
[20:07:31.168] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:31.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:68:0) after 1m0s
[20:08:31.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:68:0)
[20:08:31.197] Timer tick, asking Buildbucket for the build status
[20:08:31.691] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:31.691] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:69:0) after 1m0s
[20:09:31.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:69:0)
[20:09:31.715] Timer tick, asking Buildbucket for the build status
[20:09:32.279] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:32.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:70:0) after 1m0s
[20:10:32.348] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:70:0)
[20:10:32.348] Timer tick, asking Buildbucket for the build status
[20:10:32.601] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:32.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:71:0) after 1m0s
[20:11:32.628] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:71:0)
[20:11:32.628] Timer tick, asking Buildbucket for the build status
[20:11:32.859] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:32.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:72:0) after 1m0s
[20:12:32.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:72:0)
[20:12:32.887] Timer tick, asking Buildbucket for the build status
[20:12:33.549] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:33.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:73:0) after 1m0s
[20:13:33.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:73:0)
[20:13:33.554] Timer tick, asking Buildbucket for the build status
[20:13:34.089] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:34.089] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:74:0) after 1m0s
[20:14:34.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:74:0)
[20:14:34.245] Timer tick, asking Buildbucket for the build status
[20:14:34.529] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:34.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:75:0) after 1m0s
[20:15:34.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:75:0)
[20:15:34.734] Timer tick, asking Buildbucket for the build status
[20:15:34.943] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:34.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:76:0) after 1m0s
[20:16:35.016] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:76:0)
[20:16:35.016] Timer tick, asking Buildbucket for the build status
[20:16:36.059] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:36.059] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:77:0) after 1m0s
[20:17:36.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:77:0)
[20:17:36.131] Timer tick, asking Buildbucket for the build status
[20:17:36.537] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:36.537] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:78:0) after 1m0s
[20:18:36.550] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:78:0)
[20:18:36.550] Timer tick, asking Buildbucket for the build status
[20:18:36.716] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:36.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:79:0) after 1m0s
[20:19:36.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:79:0)
[20:19:36.827] Timer tick, asking Buildbucket for the build status
[20:19:37.084] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:37.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:80:0) after 1m0s
[20:20:37.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:80:0)
[20:20:37.208] Timer tick, asking Buildbucket for the build status
[20:20:37.587] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:37.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:81:0) after 1m0s
[20:21:37.763] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:81:0)
[20:21:37.763] Timer tick, asking Buildbucket for the build status
[20:21:38.124] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:38.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:82:0) after 1m0s
[20:22:38.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:82:0)
[20:22:38.254] Timer tick, asking Buildbucket for the build status
[20:22:38.585] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:38.585] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:83:0) after 1m0s
[20:23:38.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:83:0)
[20:23:38.723] Timer tick, asking Buildbucket for the build status
[20:23:38.941] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:38.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:84:0) after 1m0s
[20:24:38.947] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:84:0)
[20:24:38.947] Timer tick, asking Buildbucket for the build status
[20:24:39.145] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:39.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:85:0) after 1m0s
[20:25:39.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:85:0)
[20:25:39.230] Timer tick, asking Buildbucket for the build status
[20:25:39.921] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:39.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:86:0) after 1m0s
[20:26:40.068] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:86:0)
[20:26:40.068] Timer tick, asking Buildbucket for the build status
[20:26:40.311] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:40.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:87:0) after 1m0s
[20:27:40.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:87:0)
[20:27:40.336] Timer tick, asking Buildbucket for the build status
[20:27:40.485] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:40.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:88:0) after 1m0s
[20:28:40.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:88:0)
[20:28:40.724] Timer tick, asking Buildbucket for the build status
[20:28:40.963] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:40.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:89:0) after 1m0s
[20:29:41.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:89:0)
[20:29:41.041] Timer tick, asking Buildbucket for the build status
[20:29:41.346] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:41.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:90:0) after 1m0s
[20:30:41.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:90:0)
[20:30:41.410] Timer tick, asking Buildbucket for the build status
[20:30:42.244] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:42.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:91:0) after 1m0s
[20:31:42.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:91:0)
[20:31:42.752] Timer tick, asking Buildbucket for the build status
[20:31:43.357] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:43.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:92:0) after 1m0s
[20:32:43.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:92:0)
[20:32:43.402] Timer tick, asking Buildbucket for the build status
[20:32:43.657] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:43.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:93:0) after 1m0s
[20:33:43.863] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:93:0)
[20:33:43.863] Timer tick, asking Buildbucket for the build status
[20:33:44.135] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:44.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:94:0) after 1m0s
[20:34:44.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:94:0)
[20:34:44.303] Timer tick, asking Buildbucket for the build status
[20:34:44.601] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:44.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:95:0) after 1m0s
[20:35:44.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:95:0)
[20:35:44.645] Timer tick, asking Buildbucket for the build status
[20:35:46.514] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:46.514] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:96:0) after 1m0s
[20:36:46.782] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:96:0)
[20:36:46.782] Timer tick, asking Buildbucket for the build status
[20:36:47.165] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:47.165] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:97:0) after 1m0s
[20:37:47.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:97:0)
[20:37:47.193] Timer tick, asking Buildbucket for the build status
[20:37:47.573] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:47.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:98:0) after 1m0s
[20:38:47.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:98:0)
[20:38:47.604] Timer tick, asking Buildbucket for the build status
[20:38:47.831] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:47.831] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:99:0) after 1m0s
[20:39:47.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:99:0)
[20:39:47.861] Timer tick, asking Buildbucket for the build status
[20:39:48.355] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:48.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:100:0) after 1m0s
[20:40:48.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:100:0)
[20:40:48.383] Timer tick, asking Buildbucket for the build status
[20:40:48.588] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:48.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:101:0) after 1m0s
[20:41:48.618] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:101:0)
[20:41:48.618] Timer tick, asking Buildbucket for the build status
[20:41:48.843] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:48.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:102:0) after 1m0s
[20:42:48.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:102:0)
[20:42:48.916] Timer tick, asking Buildbucket for the build status
[20:42:49.834] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:49.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:103:0) after 1m0s
[20:43:49.863] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:103:0)
[20:43:49.863] Timer tick, asking Buildbucket for the build status
[20:43:50.124] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:50.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:104:0) after 1m0s
[20:44:50.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:104:0)
[20:44:50.210] Timer tick, asking Buildbucket for the build status
[20:44:50.431] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:50.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:105:0) after 1m0s
[20:45:50.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:105:0)
[20:45:50.467] Timer tick, asking Buildbucket for the build status
[20:45:50.651] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:50.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:106:0) after 1m0s
[20:46:50.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:106:0)
[20:46:50.759] Timer tick, asking Buildbucket for the build status
[20:46:51.564] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:51.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:107:0) after 1m0s
[20:47:51.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:107:0)
[20:47:51.634] Timer tick, asking Buildbucket for the build status
[20:47:51.927] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:51.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:108:0) after 1m0s
[20:48:52.025] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:108:0)
[20:48:52.025] Timer tick, asking Buildbucket for the build status
[20:48:52.574] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:52.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:109:0) after 1m0s
[20:49:52.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:109:0)
[20:49:52.601] Timer tick, asking Buildbucket for the build status
[20:49:52.806] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:52.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:110:0) after 1m0s
[20:50:53.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:110:0)
[20:50:53.075] Timer tick, asking Buildbucket for the build status
[20:50:53.247] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:53.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:111:0) after 1m0s
[20:51:53.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:111:0)
[20:51:53.344] Timer tick, asking Buildbucket for the build status
[20:51:54.032] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:54.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:112:0) after 1m0s
[20:52:54.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:112:0)
[20:52:54.113] Timer tick, asking Buildbucket for the build status
[20:52:54.586] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:54.586] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:113:0) after 1m0s
[20:53:54.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:113:0)
[20:53:54.688] Timer tick, asking Buildbucket for the build status
[20:53:55.193] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:55.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:114:0) after 1m0s
[20:54:55.289] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:114:0)
[20:54:55.289] Timer tick, asking Buildbucket for the build status
[20:54:55.618] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:55.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:115:0) after 1m0s
[20:55:55.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:115:0)
[20:55:55.631] Timer tick, asking Buildbucket for the build status
[20:55:55.865] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:55.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:116:0) after 1m0s
[20:56:55.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:116:0)
[20:56:55.917] Timer tick, asking Buildbucket for the build status
[20:56:56.790] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:56.790] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:117:0) after 1m0s
[20:57:56.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:117:0)
[20:57:56.806] Timer tick, asking Buildbucket for the build status
[20:57:57.732] Build 8894614396555343936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:57.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9060044458845433232:118:0) after 1m0s
[20:58:36.648] Received PubSub notification, asking Buildbucket for the build status
[20:58:36.780] Build 8894614396555343936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:58:36.780] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575838715577752",
"created_by": "project:chromium",
"created_ts": "1575831717875667",
"id": "8894614396555343936",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eebed353a806a953f892e3aa57fb44a4f45acc71\"}}",
"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-east1-d-8-27-74bi\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26002, \"got_angle_revision\": \"27c89d2b5c567dbe74cb854e77c45bd15bcdcde8\", \"got_dawn_revision\": \"dc3317da6cd5242e525d3230516cfd2bbff25fe9\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"eebed353a806a953f892e3aa57fb44a4f45acc71\", \"got_revision_cp\": \"refs/heads/master@{#722795}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"31916f494c2eca2ee3257733812ce21aa8f2e756\", \"got_v8_revision\": \"69827db645fcece065bf16a795a4ec8d3a51057f\", \"got_v8_revision_cp\": \"refs/heads/8.0.426@{#2}\", \"got_webrtc_revision\": \"80bc1acb9c2b9d8096f356c748ec9b57e02759c9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30031}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eebed353a806a953f892e3aa57fb44a4f45acc71\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_662609c3a18ad850d61ba5f58749e60478bc4d9d576475e0c738a1c9e2d8d890_v2\", \"builder_93a7e775fd8f3ff9ef99e2aeb686615c0006e7587b0f2c5be32706e8df4f86a4_v2\", \"builder_a7ee5da0df0016658701d083d0522e25adae25ba2fa23a313caa54097831117f_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_cf6abf55cdbfec2f8730e0d1b2ac77b75ec912af81408768f32132b6b2b4dab2_v2\", \"builder_e5bbff72983945f6847543519ce1052420cedd06fb8495f4080bfa2e6bcfd13f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-27-74bi\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4702-f6d98f9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575831964990144",
"status": "COMPLETED",
"status_changed_ts": "1575838716225846",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26002",
"builder:Deterministic Linux",
"buildset:commit/git/eebed353a806a953f892e3aa57fb44a4f45acc71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eebed353a806a953f892e3aa57fb44a4f45acc71",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060044458845433232",
"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/8894614396555343936/+/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:48ffb55c69d14510",
"user_agent:luci-scheduler"
],
"updated_ts": "1575838716246645",
"url": "https://ci.chromium.org/b/8894614396555343936",
"utcnow_ts": "1575838716771525"
}
}
[20:58:36.780] Invocation finished in 1h56m40.471733064s with status SUCCEEDED