[04:26:32.268] New invocation is queued and will start shortly
[04:26:33.337] Starting the invocation (attempt 1)
[04:26:33.374] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:26:33.375] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:26:33.375] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9064085800830980096",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b05cc8b9b9e4b1636cfde7027451970c04497c1a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9064085800830980096",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b05cc8b9b9e4b1636cfde7027451970c04497c1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b05cc8b9b9e4b1636cfde7027451970c04497c1a",
"gitiles_ref:refs/heads/master"
]
}
[04:26:35.082] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1571977593750300",
"id": "8898655738614209232",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b05cc8b9b9e4b1636cfde7027451970c04497c1a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571977594771608",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/12243",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/b05cc8b9b9e4b1636cfde7027451970c04497c1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b05cc8b9b9e4b1636cfde7027451970c04497c1a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064085800830980096",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8898655738614209232/+/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": "1571977594771745",
"url": "https://ci.chromium.org/b/8898655738614209232",
"utcnow_ts": "1571977595064578"
}
}
[04:26:35.082] Task URL: https://ci.chromium.org/b/8898655738614209232
[04:26:35.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:2:0) after 1m0s
[04:27:13.576] Received PubSub notification, asking Buildbucket for the build status
[04:27:14.858] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:35.203] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:2:0)
[04:27:35.203] Timer tick, asking Buildbucket for the build status
[04:27:36.715] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:36.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:4:0) after 1m0s
[04:28:36.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:4:0)
[04:28:36.790] Timer tick, asking Buildbucket for the build status
[04:28:37.914] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:37.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:5:0) after 1m0s
[04:29:37.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:5:0)
[04:29:37.932] Timer tick, asking Buildbucket for the build status
[04:29:38.281] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:38.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:6:0) after 1m0s
[04:30:38.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:6:0)
[04:30:38.304] Timer tick, asking Buildbucket for the build status
[04:30:38.700] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:38.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:7:0) after 1m0s
[04:31:38.795] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:7:0)
[04:31:38.795] Timer tick, asking Buildbucket for the build status
[04:31:39.273] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:39.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:8:0) after 1m0s
[04:32:39.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:8:0)
[04:32:39.320] Timer tick, asking Buildbucket for the build status
[04:32:39.697] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:39.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:9:0) after 1m0s
[04:33:39.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:9:0)
[04:33:39.754] Timer tick, asking Buildbucket for the build status
[04:33:40.046] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:40.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:10:0) after 1m0s
[04:34:40.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:10:0)
[04:34:40.094] Timer tick, asking Buildbucket for the build status
[04:34:40.469] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:40.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:11:0) after 1m0s
[04:35:40.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:11:0)
[04:35:40.536] Timer tick, asking Buildbucket for the build status
[04:35:40.867] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:40.867] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:12:0) after 1m0s
[04:36:40.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:12:0)
[04:36:40.932] Timer tick, asking Buildbucket for the build status
[04:36:41.298] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:41.298] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:13:0) after 1m0s
[04:37:41.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:13:0)
[04:37:41.444] Timer tick, asking Buildbucket for the build status
[04:37:41.664] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:41.664] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:14:0) after 1m0s
[04:38:41.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:14:0)
[04:38:41.706] Timer tick, asking Buildbucket for the build status
[04:38:42.331] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:42.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:15:0) after 1m0s
[04:39:42.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:15:0)
[04:39:42.402] Timer tick, asking Buildbucket for the build status
[04:39:43.408] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:43.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:16:0) after 1m0s
[04:40:43.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:16:0)
[04:40:43.493] Timer tick, asking Buildbucket for the build status
[04:40:44.437] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:44.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:17:0) after 1m0s
[04:41:44.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:17:0)
[04:41:44.540] Timer tick, asking Buildbucket for the build status
[04:41:44.998] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:44.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:18:0) after 1m0s
[04:42:45.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:18:0)
[04:42:45.483] Timer tick, asking Buildbucket for the build status
[04:42:45.760] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:45.760] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:19:0) after 1m0s
[04:43:45.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:19:0)
[04:43:45.971] Timer tick, asking Buildbucket for the build status
[04:43:46.574] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:46.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:20:0) after 1m0s
[04:44:46.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:20:0)
[04:44:46.583] Timer tick, asking Buildbucket for the build status
[04:44:47.532] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:47.532] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:21:0) after 1m0s
[04:45:47.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:21:0)
[04:45:47.597] Timer tick, asking Buildbucket for the build status
[04:45:48.286] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:48.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:22:0) after 1m0s
[04:46:48.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:22:0)
[04:46:48.320] Timer tick, asking Buildbucket for the build status
[04:46:48.925] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:48.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:23:0) after 1m0s
[04:47:49.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:23:0)
[04:47:49.074] Timer tick, asking Buildbucket for the build status
[04:47:52.372] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:52.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:24:0) after 1m0s
[04:48:52.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:24:0)
[04:48:52.630] Timer tick, asking Buildbucket for the build status
[04:48:53.342] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:53.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:25:0) after 1m0s
[04:49:53.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:25:0)
[04:49:53.504] Timer tick, asking Buildbucket for the build status
[04:49:53.726] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:53.726] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:26:0) after 1m0s
[04:50:54.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:26:0)
[04:50:54.022] Timer tick, asking Buildbucket for the build status
[04:50:54.975] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:54.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:27:0) after 1m0s
[04:51:55.036] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:27:0)
[04:51:55.036] Timer tick, asking Buildbucket for the build status
[04:51:55.891] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:55.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:28:0) after 1m0s
[04:52:55.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:28:0)
[04:52:55.981] Timer tick, asking Buildbucket for the build status
[04:52:56.271] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:56.271] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:29:0) after 1m0s
[04:53:56.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:29:0)
[04:53:56.304] Timer tick, asking Buildbucket for the build status
[04:53:57.232] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:57.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:30:0) after 1m0s
[04:54:57.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:30:0)
[04:54:57.394] Timer tick, asking Buildbucket for the build status
[04:54:58.084] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:58.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:31:0) after 1m0s
[04:55:58.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:31:0)
[04:55:58.113] Timer tick, asking Buildbucket for the build status
[04:55:59.731] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:59.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:32:0) after 1m0s
[04:56:59.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:32:0)
[04:56:59.878] Timer tick, asking Buildbucket for the build status
[04:57:00.117] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:00.117] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:33:0) after 1m0s
[04:58:00.292] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:33:0)
[04:58:00.292] Timer tick, asking Buildbucket for the build status
[04:58:01.538] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:01.538] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:34:0) after 1m0s
[04:59:01.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:34:0)
[04:59:01.611] Timer tick, asking Buildbucket for the build status
[04:59:02.895] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:02.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:35:0) after 1m0s
[05:00:02.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:35:0)
[05:00:02.920] Timer tick, asking Buildbucket for the build status
[05:00:03.945] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:03.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:36:0) after 1m0s
[05:01:04.167] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:36:0)
[05:01:04.168] Timer tick, asking Buildbucket for the build status
[05:01:04.697] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:04.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:37:0) after 1m0s
[05:02:04.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:37:0)
[05:02:04.908] Timer tick, asking Buildbucket for the build status
[05:02:05.661] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:05.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:38:0) after 1m0s
[05:03:05.836] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:38:0)
[05:03:05.836] Timer tick, asking Buildbucket for the build status
[05:03:06.738] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:06.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:39:0) after 1m0s
[05:04:06.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:39:0)
[05:04:06.804] Timer tick, asking Buildbucket for the build status
[05:04:07.301] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:07.301] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:40:0) after 1m0s
[05:05:07.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:40:0)
[05:05:07.359] Timer tick, asking Buildbucket for the build status
[05:05:07.955] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:07.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:41:0) after 1m0s
[05:06:08.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:41:0)
[05:06:08.029] Timer tick, asking Buildbucket for the build status
[05:06:08.211] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:08.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:42:0) after 1m0s
[05:07:08.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:42:0)
[05:07:08.321] Timer tick, asking Buildbucket for the build status
[05:07:08.700] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:08.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:43:0) after 1m0s
[05:08:08.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:43:0)
[05:08:08.858] Timer tick, asking Buildbucket for the build status
[05:08:11.441] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:11.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:44:0) after 1m0s
[05:09:11.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:44:0)
[05:09:11.476] Timer tick, asking Buildbucket for the build status
[05:09:11.684] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:11.684] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:45:0) after 1m0s
[05:10:11.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:45:0)
[05:10:11.744] Timer tick, asking Buildbucket for the build status
[05:10:12.053] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:12.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:46:0) after 1m0s
[05:11:12.158] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:46:0)
[05:11:12.158] Timer tick, asking Buildbucket for the build status
[05:11:13.130] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:13.130] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:47:0) after 1m0s
[05:12:13.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:47:0)
[05:12:13.152] Timer tick, asking Buildbucket for the build status
[05:12:13.465] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:13.465] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:48:0) after 1m0s
[05:13:13.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:48:0)
[05:13:13.508] Timer tick, asking Buildbucket for the build status
[05:13:15.892] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:15.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:49:0) after 1m0s
[05:14:15.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:49:0)
[05:14:15.916] Timer tick, asking Buildbucket for the build status
[05:14:16.257] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:16.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:50:0) after 1m0s
[05:15:16.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:50:0)
[05:15:16.282] Timer tick, asking Buildbucket for the build status
[05:15:16.630] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:16.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:51:0) after 1m0s
[05:16:16.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:51:0)
[05:16:16.669] Timer tick, asking Buildbucket for the build status
[05:16:16.865] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:16.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:52:0) after 1m0s
[05:17:16.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:52:0)
[05:17:16.907] Timer tick, asking Buildbucket for the build status
[05:17:17.241] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:17.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:53:0) after 1m0s
[05:18:17.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:53:0)
[05:18:17.263] Timer tick, asking Buildbucket for the build status
[05:18:20.019] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:20.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:54:0) after 1m0s
[05:19:20.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:54:0)
[05:19:20.048] Timer tick, asking Buildbucket for the build status
[05:19:21.651] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:21.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:55:0) after 1m0s
[05:20:21.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:55:0)
[05:20:21.663] Timer tick, asking Buildbucket for the build status
[05:20:21.791] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:21.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:56:0) after 1m0s
[05:21:21.791] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:56:0)
[05:21:21.791] Timer tick, asking Buildbucket for the build status
[05:21:22.576] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:22.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:57:0) after 1m0s
[05:22:22.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:57:0)
[05:22:22.619] Timer tick, asking Buildbucket for the build status
[05:22:23.172] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:23.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:58:0) after 1m0s
[05:23:23.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:58:0)
[05:23:23.296] Timer tick, asking Buildbucket for the build status
[05:23:23.483] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:23.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:59:0) after 1m0s
[05:24:23.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:59:0)
[05:24:23.507] Timer tick, asking Buildbucket for the build status
[05:24:24.865] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:24.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:60:0) after 1m0s
[05:25:24.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:60:0)
[05:25:24.934] Timer tick, asking Buildbucket for the build status
[05:25:25.694] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:25.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:61:0) after 1m0s
[05:26:25.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:61:0)
[05:26:25.724] Timer tick, asking Buildbucket for the build status
[05:26:26.705] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:26.705] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:62:0) after 1m0s
[05:27:26.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:62:0)
[05:27:26.833] Timer tick, asking Buildbucket for the build status
[05:27:27.291] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:27.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:63:0) after 1m0s
[05:28:27.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:63:0)
[05:28:27.271] Timer tick, asking Buildbucket for the build status
[05:28:31.582] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:31.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:64:0) after 1m0s
[05:29:31.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:64:0)
[05:29:31.642] Timer tick, asking Buildbucket for the build status
[05:29:31.885] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:31.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:65:0) after 1m0s
[05:30:31.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:65:0)
[05:30:31.924] Timer tick, asking Buildbucket for the build status
[05:30:32.566] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:32.566] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:66:0) after 1m0s
[05:31:33.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:66:0)
[05:31:33.128] Timer tick, asking Buildbucket for the build status
[05:31:34.906] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:34.906] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:67:0) after 1m0s
[05:32:34.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:67:0)
[05:32:34.970] Timer tick, asking Buildbucket for the build status
[05:32:35.206] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:35.206] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:68:0) after 1m0s
[05:33:35.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:68:0)
[05:33:35.286] Timer tick, asking Buildbucket for the build status
[05:33:35.467] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:35.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:69:0) after 1m0s
[05:34:35.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:69:0)
[05:34:35.532] Timer tick, asking Buildbucket for the build status
[05:34:36.474] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:36.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:70:0) after 1m0s
[05:35:36.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:70:0)
[05:35:36.682] Timer tick, asking Buildbucket for the build status
[05:35:37.109] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:37.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:71:0) after 1m0s
[05:36:37.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:71:0)
[05:36:37.133] Timer tick, asking Buildbucket for the build status
[05:36:37.587] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:37.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:72:0) after 1m0s
[05:37:37.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:72:0)
[05:37:37.619] Timer tick, asking Buildbucket for the build status
[05:37:38.717] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:38.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:73:0) after 1m0s
[05:38:38.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:73:0)
[05:38:38.717] Timer tick, asking Buildbucket for the build status
[05:38:39.237] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:39.237] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:74:0) after 1m0s
[05:39:39.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:74:0)
[05:39:39.290] Timer tick, asking Buildbucket for the build status
[05:39:40.385] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:40.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:75:0) after 1m0s
[05:40:40.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:75:0)
[05:40:40.446] Timer tick, asking Buildbucket for the build status
[05:40:40.881] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:40.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:76:0) after 1m0s
[05:41:40.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:76:0)
[05:41:40.913] Timer tick, asking Buildbucket for the build status
[05:41:41.414] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:41.414] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:77:0) after 1m0s
[05:42:41.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:77:0)
[05:42:41.528] Timer tick, asking Buildbucket for the build status
[05:42:42.017] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:42.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:78:0) after 1m0s
[05:43:42.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:78:0)
[05:43:42.154] Timer tick, asking Buildbucket for the build status
[05:43:42.543] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:42.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:79:0) after 1m0s
[05:44:42.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:79:0)
[05:44:42.586] Timer tick, asking Buildbucket for the build status
[05:44:43.435] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:43.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:80:0) after 1m0s
[05:45:43.525] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:80:0)
[05:45:43.525] Timer tick, asking Buildbucket for the build status
[05:45:44.015] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:44.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:81:0) after 1m0s
[05:46:44.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:81:0)
[05:46:44.048] Timer tick, asking Buildbucket for the build status
[05:46:45.049] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:45.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:82:0) after 1m0s
[05:47:45.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:82:0)
[05:47:45.099] Timer tick, asking Buildbucket for the build status
[05:47:46.379] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:46.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:83:0) after 1m0s
[05:48:46.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:83:0)
[05:48:46.520] Timer tick, asking Buildbucket for the build status
[05:48:46.995] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:46.995] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:84:0) after 1m0s
[05:49:47.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:84:0)
[05:49:47.059] Timer tick, asking Buildbucket for the build status
[05:49:48.037] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:48.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:85:0) after 1m0s
[05:50:48.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:85:0)
[05:50:48.073] Timer tick, asking Buildbucket for the build status
[05:50:48.230] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:48.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:86:0) after 1m0s
[05:51:48.362] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:86:0)
[05:51:48.363] Timer tick, asking Buildbucket for the build status
[05:51:48.836] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:48.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:87:0) after 1m0s
[05:52:48.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:87:0)
[05:52:48.903] Timer tick, asking Buildbucket for the build status
[05:52:49.549] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:49.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:88:0) after 1m0s
[05:53:49.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:88:0)
[05:53:49.665] Timer tick, asking Buildbucket for the build status
[05:53:50.443] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:50.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:89:0) after 1m0s
[05:54:50.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:89:0)
[05:54:50.526] Timer tick, asking Buildbucket for the build status
[05:54:50.939] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:50.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:90:0) after 1m0s
[05:55:51.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:90:0)
[05:55:51.057] Timer tick, asking Buildbucket for the build status
[05:55:51.514] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:51.514] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:91:0) after 1m0s
[05:56:51.548] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:91:0)
[05:56:51.548] Timer tick, asking Buildbucket for the build status
[05:56:52.047] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:52.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:92:0) after 1m0s
[05:57:52.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:92:0)
[05:57:52.184] Timer tick, asking Buildbucket for the build status
[05:57:55.765] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:55.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:93:0) after 1m0s
[05:58:56.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:93:0)
[05:58:56.199] Timer tick, asking Buildbucket for the build status
[05:58:56.530] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:56.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:94:0) after 1m0s
[05:59:56.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:94:0)
[05:59:56.854] Timer tick, asking Buildbucket for the build status
[05:59:57.285] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:57.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:95:0) after 1m0s
[06:00:57.361] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:95:0)
[06:00:57.362] Timer tick, asking Buildbucket for the build status
[06:00:57.859] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:57.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:96:0) after 1m0s
[06:01:57.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:96:0)
[06:01:57.957] Timer tick, asking Buildbucket for the build status
[06:01:58.703] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:58.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:97:0) after 1m0s
[06:02:58.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:97:0)
[06:02:58.820] Timer tick, asking Buildbucket for the build status
[06:02:59.023] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:59.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:98:0) after 1m0s
[06:03:59.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:98:0)
[06:03:59.056] Timer tick, asking Buildbucket for the build status
[06:03:59.554] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:59.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:99:0) after 1m0s
[06:04:59.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:99:0)
[06:04:59.557] Timer tick, asking Buildbucket for the build status
[06:04:59.791] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:59.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:100:0) after 1m0s
[06:05:59.834] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:100:0)
[06:05:59.834] Timer tick, asking Buildbucket for the build status
[06:06:01.594] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:01.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:101:0) after 1m0s
[06:07:01.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:101:0)
[06:07:01.631] Timer tick, asking Buildbucket for the build status
[06:07:02.286] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:02.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:102:0) after 1m0s
[06:08:02.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:102:0)
[06:08:02.368] Timer tick, asking Buildbucket for the build status
[06:08:02.612] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:02.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:103:0) after 1m0s
[06:09:02.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:103:0)
[06:09:02.631] Timer tick, asking Buildbucket for the build status
[06:09:03.508] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:03.508] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:104:0) after 1m0s
[06:10:03.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:104:0)
[06:10:03.535] Timer tick, asking Buildbucket for the build status
[06:10:04.263] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:04.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:105:0) after 1m0s
[06:11:04.291] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:105:0)
[06:11:04.291] Timer tick, asking Buildbucket for the build status
[06:11:04.659] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:04.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:106:0) after 1m0s
[06:12:04.687] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:106:0)
[06:12:04.687] Timer tick, asking Buildbucket for the build status
[06:12:05.164] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:05.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:107:0) after 1m0s
[06:13:05.191] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:107:0)
[06:13:05.192] Timer tick, asking Buildbucket for the build status
[06:13:05.495] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:05.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:108:0) after 1m0s
[06:14:05.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:108:0)
[06:14:05.515] Timer tick, asking Buildbucket for the build status
[06:14:06.051] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:06.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:109:0) after 1m0s
[06:15:06.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:109:0)
[06:15:06.056] Timer tick, asking Buildbucket for the build status
[06:15:06.576] Build 8898655738614209232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:06.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9064085800830980096:110:0) after 1m0s
[06:15:51.679] Received PubSub notification, asking Buildbucket for the build status
[06:15:52.087] Build 8898655738614209232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:15:52.087] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1571984150828340",
"created_by": "project:chromium",
"created_ts": "1571977593750300",
"id": "8898655738614209232",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b05cc8b9b9e4b1636cfde7027451970c04497c1a\"}}",
"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-32-9-z4ql\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 12243, \"got_angle_revision\": \"6b652b335259295d90702fff9f3b34988eef36f7\", \"got_dawn_revision\": \"1fdcb16b6995c54c645f17566d019ebf46229fd0\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"b05cc8b9b9e4b1636cfde7027451970c04497c1a\", \"got_revision_cp\": \"refs/heads/master@{#709362}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"24fd62c58cd1260918cf35ef6837045d96298b13\", \"got_v8_revision_cp\": \"refs/heads/8.0.62@{#1}\", \"got_webrtc_revision\": \"ef0e4d0438459d73c7eca453bda0e8d80ca0f896\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29604}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b05cc8b9b9e4b1636cfde7027451970c04497c1a\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0264569d20b29e1d5e6df044c8d1223ed84f9f22180c83dac41e8db0ff2b71db_v2\", \"builder_0449d4990cc4feb415a65e31e9088077715ff3aab07ec56c1ca7c39b14a8bb8d_v2\", \"builder_6a7ea7a29847c5e3c31f9e7f29ef0a1aa1bd0d542498088304c0bb7ba89c3242_v2\", \"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-9-z4ql\"], \"image\": [\"chrome-xenial-19101700-60651c0b41e\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4549-8dc3ae7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571977630967539",
"status": "COMPLETED",
"status_changed_ts": "1571984151169616",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/12243",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/b05cc8b9b9e4b1636cfde7027451970c04497c1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b05cc8b9b9e4b1636cfde7027451970c04497c1a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064085800830980096",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8898655738614209232/+/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:4819fc941f5c5d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1571984151187093",
"url": "https://ci.chromium.org/b/8898655738614209232",
"utcnow_ts": "1571984152075151"
}
}
[06:15:52.087] Invocation finished in 1h49m19.83548662s with status SUCCEEDED