[21:25:28.450] New invocation is queued and will start shortly
[21:25:29.566] Starting the invocation (attempt 1)
[21:25:29.607] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:25:29.607] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:25:29.607] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055777370957116528",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"773b0221d9bb01ba3cc39a94e08048cb3da2454f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9055777370957116528",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/773b0221d9bb01ba3cc39a94e08048cb3da2454f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/773b0221d9bb01ba3cc39a94e08048cb3da2454f",
"gitiles_ref:refs/heads/master"
]
}
[21:25:30.572] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579901129772059",
"id": "8890347308906424032",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"773b0221d9bb01ba3cc39a94e08048cb3da2454f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579901130263052",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26578",
"builder:Deterministic Linux",
"buildset:commit/git/773b0221d9bb01ba3cc39a94e08048cb3da2454f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/773b0221d9bb01ba3cc39a94e08048cb3da2454f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055777370957116528",
"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/8890347308906424032/+/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": "1579901130263160",
"url": "https://ci.chromium.org/b/8890347308906424032",
"utcnow_ts": "1579901130560492"
}
}
[21:25:30.572] Task URL: https://ci.chromium.org/b/8890347308906424032
[21:25:30.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:2:0) after 1m0s
[21:25:34.885] Received PubSub notification, asking Buildbucket for the build status
[21:25:35.073] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:30.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:2:0)
[21:26:30.657] Timer tick, asking Buildbucket for the build status
[21:26:30.802] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:30.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:4:0) after 1m0s
[21:27:30.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:4:0)
[21:27:30.886] Timer tick, asking Buildbucket for the build status
[21:27:32.011] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:32.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:5:0) after 1m0s
[21:28:32.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:5:0)
[21:28:32.028] Timer tick, asking Buildbucket for the build status
[21:28:32.174] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:32.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:6:0) after 1m0s
[21:29:32.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:6:0)
[21:29:32.195] Timer tick, asking Buildbucket for the build status
[21:29:32.384] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:32.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:7:0) after 1m0s
[21:30:32.380] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:7:0)
[21:30:32.380] Timer tick, asking Buildbucket for the build status
[21:30:33.032] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:33.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:8:0) after 1m0s
[21:31:33.129] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:8:0)
[21:31:33.129] Timer tick, asking Buildbucket for the build status
[21:31:33.697] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:33.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:9:0) after 1m0s
[21:32:33.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:9:0)
[21:32:33.714] Timer tick, asking Buildbucket for the build status
[21:32:33.879] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:33.879] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:10:0) after 1m0s
[21:33:33.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:10:0)
[21:33:33.956] Timer tick, asking Buildbucket for the build status
[21:33:34.187] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:34.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:11:0) after 1m0s
[21:34:34.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:11:0)
[21:34:34.254] Timer tick, asking Buildbucket for the build status
[21:34:34.976] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:34.976] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:12:0) after 1m0s
[21:35:35.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:12:0)
[21:35:35.074] Timer tick, asking Buildbucket for the build status
[21:35:35.356] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:35.356] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:13:0) after 1m0s
[21:36:35.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:13:0)
[21:36:35.477] Timer tick, asking Buildbucket for the build status
[21:36:35.751] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:35.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:14:0) after 1m0s
[21:37:35.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:14:0)
[21:37:35.798] Timer tick, asking Buildbucket for the build status
[21:37:36.024] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:36.024] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:15:0) after 1m0s
[21:38:36.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:15:0)
[21:38:36.266] Timer tick, asking Buildbucket for the build status
[21:38:36.461] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:36.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:16:0) after 1m0s
[21:39:36.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:16:0)
[21:39:36.735] Timer tick, asking Buildbucket for the build status
[21:39:36.896] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:36.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:17:0) after 1m0s
[21:40:36.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:17:0)
[21:40:36.957] Timer tick, asking Buildbucket for the build status
[21:40:37.181] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:37.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:18:0) after 1m0s
[21:41:37.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:18:0)
[21:41:37.189] Timer tick, asking Buildbucket for the build status
[21:41:37.316] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:37.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:19:0) after 1m0s
[21:42:37.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:19:0)
[21:42:37.363] Timer tick, asking Buildbucket for the build status
[21:42:37.860] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:37.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:20:0) after 1m0s
[21:43:37.872] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:20:0)
[21:43:37.872] Timer tick, asking Buildbucket for the build status
[21:43:38.571] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:38.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:21:0) after 1m0s
[21:44:38.637] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:21:0)
[21:44:38.637] Timer tick, asking Buildbucket for the build status
[21:44:38.788] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:38.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:22:0) after 1m0s
[21:45:39.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:22:0)
[21:45:39.075] Timer tick, asking Buildbucket for the build status
[21:45:39.408] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:39.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:23:0) after 1m0s
[21:46:39.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:23:0)
[21:46:39.512] Timer tick, asking Buildbucket for the build status
[21:46:39.657] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:39.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:24:0) after 1m0s
[21:47:39.758] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:24:0)
[21:47:39.758] Timer tick, asking Buildbucket for the build status
[21:47:40.032] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:40.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:25:0) after 1m0s
[21:48:40.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:25:0)
[21:48:40.222] Timer tick, asking Buildbucket for the build status
[21:48:40.384] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:40.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:26:0) after 1m0s
[21:49:40.461] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:26:0)
[21:49:40.461] Timer tick, asking Buildbucket for the build status
[21:49:41.048] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:41.048] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:27:0) after 1m0s
[21:50:41.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:27:0)
[21:50:41.138] Timer tick, asking Buildbucket for the build status
[21:50:41.331] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:41.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:28:0) after 1m0s
[21:51:41.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:28:0)
[21:51:41.540] Timer tick, asking Buildbucket for the build status
[21:51:42.228] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:42.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:29:0) after 1m0s
[21:52:42.325] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:29:0)
[21:52:42.325] Timer tick, asking Buildbucket for the build status
[21:52:42.717] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:42.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:30:0) after 1m0s
[21:53:42.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:30:0)
[21:53:42.713] Timer tick, asking Buildbucket for the build status
[21:53:43.056] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:43.056] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:31:0) after 1m0s
[21:54:43.116] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:31:0)
[21:54:43.116] Timer tick, asking Buildbucket for the build status
[21:54:43.587] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:43.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:32:0) after 1m0s
[21:55:43.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:32:0)
[21:55:43.619] Timer tick, asking Buildbucket for the build status
[21:55:44.204] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:44.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:33:0) after 1m0s
[21:56:44.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:33:0)
[21:56:44.263] Timer tick, asking Buildbucket for the build status
[21:56:44.673] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:44.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:34:0) after 1m0s
[21:57:44.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:34:0)
[21:57:44.730] Timer tick, asking Buildbucket for the build status
[21:57:45.186] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:45.186] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:35:0) after 1m0s
[21:58:45.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:35:0)
[21:58:45.240] Timer tick, asking Buildbucket for the build status
[21:58:45.767] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:45.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:36:0) after 1m0s
[21:59:45.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:36:0)
[21:59:45.801] Timer tick, asking Buildbucket for the build status
[21:59:46.501] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:46.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:37:0) after 1m0s
[22:00:46.686] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:37:0)
[22:00:46.686] Timer tick, asking Buildbucket for the build status
[22:00:46.903] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:46.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:38:0) after 1m0s
[22:01:47.023] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:38:0)
[22:01:47.023] Timer tick, asking Buildbucket for the build status
[22:01:47.302] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:47.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:39:0) after 1m0s
[22:02:47.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:39:0)
[22:02:47.342] Timer tick, asking Buildbucket for the build status
[22:02:48.002] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:48.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:40:0) after 1m0s
[22:03:48.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:40:0)
[22:03:48.012] Timer tick, asking Buildbucket for the build status
[22:03:48.550] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:48.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:41:0) after 1m0s
[22:04:48.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:41:0)
[22:04:48.688] Timer tick, asking Buildbucket for the build status
[22:04:48.885] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:48.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:42:0) after 1m0s
[22:05:49.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:42:0)
[22:05:49.071] Timer tick, asking Buildbucket for the build status
[22:05:49.339] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:49.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:43:0) after 1m0s
[22:06:49.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:43:0)
[22:06:49.395] Timer tick, asking Buildbucket for the build status
[22:06:50.282] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:50.282] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:44:0) after 1m0s
[22:07:50.315] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:44:0)
[22:07:50.315] Timer tick, asking Buildbucket for the build status
[22:07:52.361] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:52.361] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:45:0) after 1m0s
[22:08:52.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:45:0)
[22:08:52.420] Timer tick, asking Buildbucket for the build status
[22:08:52.725] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:52.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:46:0) after 1m0s
[22:09:52.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:46:0)
[22:09:52.817] Timer tick, asking Buildbucket for the build status
[22:09:52.953] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:52.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:47:0) after 1m0s
[22:10:52.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:47:0)
[22:10:52.990] Timer tick, asking Buildbucket for the build status
[22:10:53.650] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:53.650] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:48:0) after 1m0s
[22:11:53.673] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:48:0)
[22:11:53.674] Timer tick, asking Buildbucket for the build status
[22:11:53.897] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:53.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:49:0) after 1m0s
[22:12:53.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:49:0)
[22:12:53.916] Timer tick, asking Buildbucket for the build status
[22:12:54.534] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:54.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:50:0) after 1m0s
[22:13:54.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:50:0)
[22:13:54.631] Timer tick, asking Buildbucket for the build status
[22:13:54.895] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:54.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:51:0) after 1m0s
[22:14:55.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:51:0)
[22:14:55.024] Timer tick, asking Buildbucket for the build status
[22:14:55.199] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:55.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:52:0) after 1m0s
[22:15:55.225] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:52:0)
[22:15:55.225] Timer tick, asking Buildbucket for the build status
[22:15:55.547] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:55.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:53:0) after 1m0s
[22:16:55.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:53:0)
[22:16:55.713] Timer tick, asking Buildbucket for the build status
[22:16:56.203] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:56.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:54:0) after 1m0s
[22:17:56.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:54:0)
[22:17:56.262] Timer tick, asking Buildbucket for the build status
[22:17:56.470] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:56.470] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:55:0) after 1m0s
[22:18:56.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:55:0)
[22:18:56.535] Timer tick, asking Buildbucket for the build status
[22:18:56.910] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:56.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:56:0) after 1m0s
[22:19:56.940] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:56:0)
[22:19:56.940] Timer tick, asking Buildbucket for the build status
[22:19:57.629] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:57.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:57:0) after 1m0s
[22:20:57.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:57:0)
[22:20:57.742] Timer tick, asking Buildbucket for the build status
[22:20:57.955] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:57.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:58:0) after 1m0s
[22:21:58.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:58:0)
[22:21:58.037] Timer tick, asking Buildbucket for the build status
[22:21:58.397] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:58.397] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:59:0) after 1m0s
[22:22:58.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:59:0)
[22:22:58.466] Timer tick, asking Buildbucket for the build status
[22:22:58.832] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:58.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:60:0) after 1m0s
[22:23:59.171] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:60:0)
[22:23:59.171] Timer tick, asking Buildbucket for the build status
[22:23:59.467] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:59.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:61:0) after 1m0s
[22:24:59.640] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:61:0)
[22:24:59.640] Timer tick, asking Buildbucket for the build status
[22:25:02.195] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:02.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:62:0) after 1m0s
[22:26:02.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:62:0)
[22:26:02.282] Timer tick, asking Buildbucket for the build status
[22:26:02.501] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:02.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:63:0) after 1m0s
[22:27:02.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:63:0)
[22:27:02.601] Timer tick, asking Buildbucket for the build status
[22:27:03.379] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:03.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:64:0) after 1m0s
[22:28:03.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:64:0)
[22:28:03.479] Timer tick, asking Buildbucket for the build status
[22:28:04.126] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:04.126] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:65:0) after 1m0s
[22:29:04.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:65:0)
[22:29:04.236] Timer tick, asking Buildbucket for the build status
[22:29:04.395] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:04.395] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:66:0) after 1m0s
[22:30:04.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:66:0)
[22:30:04.785] Timer tick, asking Buildbucket for the build status
[22:30:05.774] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:05.774] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:67:0) after 1m0s
[22:31:05.873] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:67:0)
[22:31:05.873] Timer tick, asking Buildbucket for the build status
[22:31:06.082] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:06.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:68:0) after 1m0s
[22:32:06.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:68:0)
[22:32:06.248] Timer tick, asking Buildbucket for the build status
[22:32:06.431] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:06.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:69:0) after 1m0s
[22:33:06.511] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:69:0)
[22:33:06.511] Timer tick, asking Buildbucket for the build status
[22:33:06.936] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:06.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:70:0) after 1m0s
[22:34:07.079] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:70:0)
[22:34:07.079] Timer tick, asking Buildbucket for the build status
[22:34:07.233] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:07.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:71:0) after 1m0s
[22:35:07.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:71:0)
[22:35:07.342] Timer tick, asking Buildbucket for the build status
[22:35:08.044] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:08.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:72:0) after 1m0s
[22:36:08.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:72:0)
[22:36:08.099] Timer tick, asking Buildbucket for the build status
[22:36:08.423] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:08.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:73:0) after 1m0s
[22:37:08.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:73:0)
[22:37:08.549] Timer tick, asking Buildbucket for the build status
[22:37:08.726] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:08.726] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:74:0) after 1m0s
[22:38:08.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:74:0)
[22:38:08.817] Timer tick, asking Buildbucket for the build status
[22:38:10.615] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:10.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:75:0) after 1m0s
[22:39:10.949] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:75:0)
[22:39:10.949] Timer tick, asking Buildbucket for the build status
[22:39:11.288] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:11.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:76:0) after 1m0s
[22:40:11.506] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:76:0)
[22:40:11.506] Timer tick, asking Buildbucket for the build status
[22:40:13.625] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:13.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:77:0) after 1m0s
[22:41:13.815] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:77:0)
[22:41:13.815] Timer tick, asking Buildbucket for the build status
[22:41:13.972] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:13.972] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:78:0) after 1m0s
[22:42:14.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:78:0)
[22:42:14.207] Timer tick, asking Buildbucket for the build status
[22:42:14.823] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:14.823] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:79:0) after 1m0s
[22:43:14.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:79:0)
[22:43:14.832] Timer tick, asking Buildbucket for the build status
[22:43:17.497] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:17.497] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:80:0) after 1m0s
[22:44:17.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:80:0)
[22:44:17.665] Timer tick, asking Buildbucket for the build status
[22:44:19.628] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:19.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:81:0) after 1m0s
[22:45:19.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:81:0)
[22:45:19.666] Timer tick, asking Buildbucket for the build status
[22:45:19.832] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:19.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:82:0) after 1m0s
[22:46:19.902] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:82:0)
[22:46:19.902] Timer tick, asking Buildbucket for the build status
[22:46:20.093] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:20.093] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:83:0) after 1m0s
[22:47:20.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:83:0)
[22:47:20.306] Timer tick, asking Buildbucket for the build status
[22:47:20.816] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:20.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:84:0) after 1m0s
[22:48:20.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:84:0)
[22:48:20.903] Timer tick, asking Buildbucket for the build status
[22:48:21.364] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:21.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:85:0) after 1m0s
[22:49:21.396] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:85:0)
[22:49:21.396] Timer tick, asking Buildbucket for the build status
[22:49:21.554] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:21.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:86:0) after 1m0s
[22:50:21.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:86:0)
[22:50:21.731] Timer tick, asking Buildbucket for the build status
[22:50:21.872] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:21.872] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:87:0) after 1m0s
[22:51:21.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:87:0)
[22:51:21.934] Timer tick, asking Buildbucket for the build status
[22:51:22.917] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:22.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:88:0) after 1m0s
[22:52:22.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:88:0)
[22:52:22.954] Timer tick, asking Buildbucket for the build status
[22:52:24.115] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:24.115] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:89:0) after 1m0s
[22:53:24.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:89:0)
[22:53:24.166] Timer tick, asking Buildbucket for the build status
[22:53:24.355] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:24.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:90:0) after 1m0s
[22:54:24.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:90:0)
[22:54:24.378] Timer tick, asking Buildbucket for the build status
[22:54:24.636] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:24.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:91:0) after 1m0s
[22:55:24.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:91:0)
[22:55:24.660] Timer tick, asking Buildbucket for the build status
[22:55:25.251] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:25.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:92:0) after 1m0s
[22:56:25.270] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:92:0)
[22:56:25.270] Timer tick, asking Buildbucket for the build status
[22:56:25.427] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:25.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:93:0) after 1m0s
[22:57:25.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:93:0)
[22:57:25.452] Timer tick, asking Buildbucket for the build status
[22:57:25.684] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:25.684] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:94:0) after 1m0s
[22:58:25.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:94:0)
[22:58:25.694] Timer tick, asking Buildbucket for the build status
[22:58:25.882] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:25.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:95:0) after 1m0s
[22:59:25.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:95:0)
[22:59:25.951] Timer tick, asking Buildbucket for the build status
[22:59:26.193] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:26.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:96:0) after 1m0s
[23:00:26.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:96:0)
[23:00:26.237] Timer tick, asking Buildbucket for the build status
[23:00:26.408] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:26.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:97:0) after 1m0s
[23:01:26.443] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:97:0)
[23:01:26.443] Timer tick, asking Buildbucket for the build status
[23:01:26.637] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:26.637] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:98:0) after 1m0s
[23:02:26.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:98:0)
[23:02:26.833] Timer tick, asking Buildbucket for the build status
[23:02:27.019] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:27.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:99:0) after 1m0s
[23:03:27.107] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:99:0)
[23:03:27.107] Timer tick, asking Buildbucket for the build status
[23:03:27.635] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:27.635] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:100:0) after 1m0s
[23:04:27.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:100:0)
[23:04:27.662] Timer tick, asking Buildbucket for the build status
[23:04:27.958] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:27.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:101:0) after 1m0s
[23:05:28.050] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:101:0)
[23:05:28.050] Timer tick, asking Buildbucket for the build status
[23:05:29.359] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:29.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:102:0) after 1m0s
[23:06:29.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:102:0)
[23:06:29.405] Timer tick, asking Buildbucket for the build status
[23:06:30.363] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:30.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:103:0) after 1m0s
[23:07:30.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:103:0)
[23:07:30.378] Timer tick, asking Buildbucket for the build status
[23:07:30.890] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:30.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:104:0) after 1m0s
[23:08:30.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:104:0)
[23:08:30.915] Timer tick, asking Buildbucket for the build status
[23:08:31.046] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:31.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:105:0) after 1m0s
[23:09:31.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:105:0)
[23:09:31.101] Timer tick, asking Buildbucket for the build status
[23:09:31.326] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:31.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:106:0) after 1m0s
[23:10:31.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:106:0)
[23:10:31.401] Timer tick, asking Buildbucket for the build status
[23:10:31.651] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:31.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:107:0) after 1m0s
[23:11:31.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:107:0)
[23:11:31.715] Timer tick, asking Buildbucket for the build status
[23:11:31.854] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:31.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:108:0) after 1m0s
[23:12:31.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:108:0)
[23:12:31.934] Timer tick, asking Buildbucket for the build status
[23:12:32.113] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:32.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:109:0) after 1m0s
[23:13:32.130] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:109:0)
[23:13:32.130] Timer tick, asking Buildbucket for the build status
[23:13:32.337] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:32.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:110:0) after 1m0s
[23:14:32.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:110:0)
[23:14:32.365] Timer tick, asking Buildbucket for the build status
[23:14:32.648] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:32.648] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:111:0) after 1m0s
[23:15:32.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:111:0)
[23:15:32.725] Timer tick, asking Buildbucket for the build status
[23:15:33.406] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:33.406] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:112:0) after 1m0s
[23:16:33.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:112:0)
[23:16:33.433] Timer tick, asking Buildbucket for the build status
[23:16:33.949] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:33.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:113:0) after 1m0s
[23:17:34.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:113:0)
[23:17:34.078] Timer tick, asking Buildbucket for the build status
[23:17:35.011] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:35.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:114:0) after 1m0s
[23:18:35.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:114:0)
[23:18:35.331] Timer tick, asking Buildbucket for the build status
[23:18:35.547] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:35.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:115:0) after 1m0s
[23:19:35.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:115:0)
[23:19:35.726] Timer tick, asking Buildbucket for the build status
[23:19:35.893] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:35.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:116:0) after 1m0s
[23:20:35.961] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:116:0)
[23:20:35.961] Timer tick, asking Buildbucket for the build status
[23:20:36.153] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:36.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:117:0) after 1m0s
[23:21:36.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:117:0)
[23:21:36.231] Timer tick, asking Buildbucket for the build status
[23:21:36.415] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:36.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:118:0) after 1m0s
[23:22:36.417] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:118:0)
[23:22:36.417] Timer tick, asking Buildbucket for the build status
[23:22:37.232] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:37.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:119:0) after 1m0s
[23:23:37.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:119:0)
[23:23:37.290] Timer tick, asking Buildbucket for the build status
[23:23:37.757] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:37.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:120:0) after 1m0s
[23:24:37.789] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:120:0)
[23:24:37.789] Timer tick, asking Buildbucket for the build status
[23:24:37.971] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:37.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:121:0) after 1m0s
[23:25:38.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:121:0)
[23:25:38.012] Timer tick, asking Buildbucket for the build status
[23:25:38.342] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:38.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:122:0) after 1m0s
[23:26:38.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:122:0)
[23:26:38.414] Timer tick, asking Buildbucket for the build status
[23:26:39.051] Build 8890347308906424032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:39.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055777370957116528:123:0) after 1m0s
[23:26:59.773] Received PubSub notification, asking Buildbucket for the build status
[23:26:59.909] Build 8890347308906424032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:26:59.909] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579908419092356",
"created_by": "project:chromium",
"created_ts": "1579901129772059",
"id": "8890347308906424032",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"773b0221d9bb01ba3cc39a94e08048cb3da2454f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-49-i16j\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26578, \"got_angle_revision\": \"453926f51ebd68616ec1b2396b13ac826409c865\", \"got_dawn_revision\": \"fa06dd0b62104c7e424cec84e44fc9e7cb5c3460\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"773b0221d9bb01ba3cc39a94e08048cb3da2454f\", \"got_revision_cp\": \"refs/heads/master@{#735099}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"748ad200897b5023ba16e527aa1221400f90b4fe\", \"got_v8_revision\": \"516ed977547eb6b62b9c9b9deb5f6d2da03278b5\", \"got_v8_revision_cp\": \"refs/heads/8.1.279@{#1}\", \"got_webrtc_revision\": \"760fd5249488a7a8698679a026b247423caa7cce\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30366}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"773b0221d9bb01ba3cc39a94e08048cb3da2454f\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_016577e073ce9abf0fa10d80f88bc2caf8f81662b409bd6e59fa52089e44a3df_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_ee0cba3c54f4de5afe190f5f1f18eea3c236437d0f634917582eff9316b81bdc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-49-i16j\"], \"image\": [\"chrome-xenial-20011200-47b90f1b63b\"], \"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\": [\"4792-2014df3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579901133038690",
"status": "COMPLETED",
"status_changed_ts": "1579908419418770",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26578",
"builder:Deterministic Linux",
"buildset:commit/git/773b0221d9bb01ba3cc39a94e08048cb3da2454f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/773b0221d9bb01ba3cc39a94e08048cb3da2454f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055777370957116528",
"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/8890347308906424032/+/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:49f2439f52aed810",
"user_agent:luci-scheduler"
],
"updated_ts": "1579908419423736",
"url": "https://ci.chromium.org/b/8890347308906424032",
"utcnow_ts": "1579908419903055"
}
}
[23:26:59.909] Invocation finished in 2h1m31.476424449s with status SUCCEEDED