[16:27:14.546] New invocation is queued and will start shortly
[16:27:18.836] Starting the invocation (attempt 1)
[16:27:18.901] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:27:18.901] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:27:18.901] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055161955311041504",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d62cf5dae568d470e96839d3227e0b48d7ee98ca\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9055161955311041504",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d62cf5dae568d470e96839d3227e0b48d7ee98ca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d62cf5dae568d470e96839d3227e0b48d7ee98ca",
"gitiles_ref:refs/heads/master"
]
}
[16:27:19.779] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1580488039188654",
"id": "8889731889778534240",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d62cf5dae568d470e96839d3227e0b48d7ee98ca\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580488039554684",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/14636",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/d62cf5dae568d470e96839d3227e0b48d7ee98ca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d62cf5dae568d470e96839d3227e0b48d7ee98ca",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055161955311041504",
"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/8889731889778534240/+/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": "1580488039554786",
"url": "https://ci.chromium.org/b/8889731889778534240",
"utcnow_ts": "1580488039768919"
}
}
[16:27:19.779] Task URL: https://ci.chromium.org/b/8889731889778534240
[16:27:19.779] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:2:0) after 1m0s
[16:27:25.311] Received PubSub notification, asking Buildbucket for the build status
[16:27:25.461] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:19.797] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:2:0)
[16:28:19.797] Timer tick, asking Buildbucket for the build status
[16:28:20.064] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:20.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:4:0) after 1m0s
[16:29:20.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:4:0)
[16:29:20.133] Timer tick, asking Buildbucket for the build status
[16:29:20.256] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:20.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:5:0) after 1m0s
[16:30:20.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:5:0)
[16:30:20.359] Timer tick, asking Buildbucket for the build status
[16:30:20.534] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:20.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:6:0) after 1m0s
[16:31:20.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:6:0)
[16:31:20.505] Timer tick, asking Buildbucket for the build status
[16:31:20.715] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:20.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:7:0) after 1m0s
[16:32:20.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:7:0)
[16:32:20.813] Timer tick, asking Buildbucket for the build status
[16:32:20.987] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:20.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:8:0) after 1m0s
[16:33:21.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:8:0)
[16:33:21.184] Timer tick, asking Buildbucket for the build status
[16:33:21.511] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:21.511] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:9:0) after 1m0s
[16:34:21.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:9:0)
[16:34:21.534] Timer tick, asking Buildbucket for the build status
[16:34:21.664] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:21.664] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:10:0) after 1m0s
[16:35:21.672] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:10:0)
[16:35:21.672] Timer tick, asking Buildbucket for the build status
[16:35:21.980] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:21.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:11:0) after 1m0s
[16:36:22.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:11:0)
[16:36:22.076] Timer tick, asking Buildbucket for the build status
[16:36:22.385] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:22.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:12:0) after 1m0s
[16:37:22.553] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:12:0)
[16:37:22.553] Timer tick, asking Buildbucket for the build status
[16:37:22.723] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:22.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:13:0) after 1m0s
[16:38:22.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:13:0)
[16:38:22.811] Timer tick, asking Buildbucket for the build status
[16:38:23.027] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:23.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:14:0) after 1m0s
[16:39:23.167] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:14:0)
[16:39:23.167] Timer tick, asking Buildbucket for the build status
[16:39:23.319] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:23.319] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:15:0) after 1m0s
[16:40:23.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:15:0)
[16:40:23.442] Timer tick, asking Buildbucket for the build status
[16:40:23.676] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:23.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:16:0) after 1m0s
[16:41:23.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:16:0)
[16:41:23.741] Timer tick, asking Buildbucket for the build status
[16:41:24.087] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:24.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:17:0) after 1m0s
[16:42:24.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:17:0)
[16:42:24.104] Timer tick, asking Buildbucket for the build status
[16:42:24.328] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:24.328] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:18:0) after 1m0s
[16:43:24.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:18:0)
[16:43:24.344] Timer tick, asking Buildbucket for the build status
[16:43:24.586] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:24.586] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:19:0) after 1m0s
[16:44:24.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:19:0)
[16:44:24.878] Timer tick, asking Buildbucket for the build status
[16:44:25.568] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:25.568] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:20:0) after 1m0s
[16:45:25.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:20:0)
[16:45:25.711] Timer tick, asking Buildbucket for the build status
[16:45:25.891] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:25.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:21:0) after 1m0s
[16:46:25.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:21:0)
[16:46:25.950] Timer tick, asking Buildbucket for the build status
[16:46:26.505] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:26.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:22:0) after 1m0s
[16:47:26.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:22:0)
[16:47:26.664] Timer tick, asking Buildbucket for the build status
[16:47:26.893] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:26.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:23:0) after 1m0s
[16:48:35.590] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:23:0)
[16:48:35.590] Timer tick, asking Buildbucket for the build status
[16:48:36.572] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:36.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:24:0) after 1m0s
[16:49:39.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:24:0)
[16:49:39.446] Timer tick, asking Buildbucket for the build status
[16:49:39.840] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:39.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:25:0) after 1m0s
[16:50:39.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:25:0)
[16:50:39.982] Timer tick, asking Buildbucket for the build status
[16:50:40.154] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:40.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:26:0) after 1m0s
[16:51:40.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:26:0)
[16:51:40.210] Timer tick, asking Buildbucket for the build status
[16:51:40.771] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:40.771] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:27:0) after 1m0s
[16:52:40.815] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:27:0)
[16:52:40.815] Timer tick, asking Buildbucket for the build status
[16:52:40.984] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:40.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:28:0) after 1m0s
[16:53:41.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:28:0)
[16:53:41.039] Timer tick, asking Buildbucket for the build status
[16:53:41.717] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:41.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:29:0) after 1m0s
[16:54:41.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:29:0)
[16:54:41.798] Timer tick, asking Buildbucket for the build status
[16:54:42.092] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:42.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:30:0) after 1m0s
[16:55:42.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:30:0)
[16:55:42.111] Timer tick, asking Buildbucket for the build status
[16:55:42.316] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:42.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:31:0) after 1m0s
[16:56:42.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:31:0)
[16:56:42.598] Timer tick, asking Buildbucket for the build status
[16:56:44.144] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:44.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:32:0) after 1m0s
[16:57:44.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:32:0)
[16:57:44.302] Timer tick, asking Buildbucket for the build status
[16:57:44.593] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:44.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:33:0) after 1m0s
[16:58:44.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:33:0)
[16:58:44.675] Timer tick, asking Buildbucket for the build status
[16:58:44.864] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:44.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:34:0) after 1m0s
[16:59:44.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:34:0)
[16:59:44.963] Timer tick, asking Buildbucket for the build status
[16:59:45.800] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:45.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:35:0) after 1m0s
[17:00:45.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:35:0)
[17:00:45.979] Timer tick, asking Buildbucket for the build status
[17:00:47.354] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:47.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:36:0) after 1m0s
[17:01:47.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:36:0)
[17:01:47.497] Timer tick, asking Buildbucket for the build status
[17:01:47.697] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:47.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:37:0) after 1m0s
[17:02:47.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:37:0)
[17:02:47.775] Timer tick, asking Buildbucket for the build status
[17:02:47.959] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:47.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:38:0) after 1m0s
[17:03:48.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:38:0)
[17:03:48.005] Timer tick, asking Buildbucket for the build status
[17:03:48.759] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:48.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:39:0) after 1m0s
[17:04:48.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:39:0)
[17:04:48.864] Timer tick, asking Buildbucket for the build status
[17:04:49.386] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:49.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:40:0) after 1m0s
[17:05:49.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:40:0)
[17:05:49.544] Timer tick, asking Buildbucket for the build status
[17:05:49.688] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:49.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:41:0) after 1m0s
[17:06:49.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:41:0)
[17:06:49.716] Timer tick, asking Buildbucket for the build status
[17:06:49.949] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:49.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:42:0) after 1m0s
[17:07:50.033] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:42:0)
[17:07:50.033] Timer tick, asking Buildbucket for the build status
[17:07:50.561] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:50.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:43:0) after 1m0s
[17:08:50.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:43:0)
[17:08:50.588] Timer tick, asking Buildbucket for the build status
[17:08:51.154] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:51.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:44:0) after 1m0s
[17:09:51.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:44:0)
[17:09:51.244] Timer tick, asking Buildbucket for the build status
[17:09:51.408] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:51.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:45:0) after 1m0s
[17:10:51.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:45:0)
[17:10:51.451] Timer tick, asking Buildbucket for the build status
[17:10:51.686] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:51.686] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:46:0) after 1m0s
[17:11:51.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:46:0)
[17:11:51.785] Timer tick, asking Buildbucket for the build status
[17:11:52.016] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:52.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:47:0) after 1m0s
[17:12:52.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:47:0)
[17:12:52.093] Timer tick, asking Buildbucket for the build status
[17:12:52.401] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:52.401] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:48:0) after 1m0s
[17:13:52.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:48:0)
[17:13:52.547] Timer tick, asking Buildbucket for the build status
[17:13:52.704] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:52.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:49:0) after 1m0s
[17:14:52.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:49:0)
[17:14:52.707] Timer tick, asking Buildbucket for the build status
[17:14:53.137] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:53.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:50:0) after 1m0s
[17:15:53.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:50:0)
[17:15:53.202] Timer tick, asking Buildbucket for the build status
[17:15:53.863] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:53.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:51:0) after 1m0s
[17:16:53.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:51:0)
[17:16:53.914] Timer tick, asking Buildbucket for the build status
[17:16:54.783] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:54.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:52:0) after 1m0s
[17:17:54.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:52:0)
[17:17:54.838] Timer tick, asking Buildbucket for the build status
[17:17:55.009] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:55.009] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:53:0) after 1m0s
[17:18:55.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:53:0)
[17:18:55.099] Timer tick, asking Buildbucket for the build status
[17:18:55.504] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:55.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:54:0) after 1m0s
[17:19:55.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:54:0)
[17:19:55.595] Timer tick, asking Buildbucket for the build status
[17:19:55.797] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:55.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:55:0) after 1m0s
[17:20:55.947] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:55:0)
[17:20:55.947] Timer tick, asking Buildbucket for the build status
[17:20:56.352] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:56.352] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:56:0) after 1m0s
[17:21:56.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:56:0)
[17:21:56.429] Timer tick, asking Buildbucket for the build status
[17:21:56.654] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:56.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:57:0) after 1m0s
[17:22:56.791] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:57:0)
[17:22:56.791] Timer tick, asking Buildbucket for the build status
[17:22:56.993] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:56.993] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:58:0) after 1m0s
[17:23:57.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:58:0)
[17:23:57.189] Timer tick, asking Buildbucket for the build status
[17:23:57.458] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:57.458] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:59:0) after 1m0s
[17:24:57.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:59:0)
[17:24:57.549] Timer tick, asking Buildbucket for the build status
[17:24:58.597] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:58.597] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:60:0) after 1m0s
[17:25:58.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:60:0)
[17:25:58.752] Timer tick, asking Buildbucket for the build status
[17:25:58.996] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:58.996] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:61:0) after 1m0s
[17:26:59.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:61:0)
[17:26:59.263] Timer tick, asking Buildbucket for the build status
[17:26:59.458] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:59.458] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:62:0) after 1m0s
[17:27:59.708] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:62:0)
[17:27:59.708] Timer tick, asking Buildbucket for the build status
[17:27:59.978] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:59.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:63:0) after 1m0s
[17:29:00.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:63:0)
[17:29:00.208] Timer tick, asking Buildbucket for the build status
[17:29:00.587] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:00.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:64:0) after 1m0s
[17:30:00.758] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:64:0)
[17:30:00.758] Timer tick, asking Buildbucket for the build status
[17:30:02.872] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:02.872] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:65:0) after 1m0s
[17:31:03.150] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:65:0)
[17:31:03.150] Timer tick, asking Buildbucket for the build status
[17:31:03.359] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:03.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:66:0) after 1m0s
[17:32:03.614] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:66:0)
[17:32:03.614] Timer tick, asking Buildbucket for the build status
[17:32:04.490] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:04.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:67:0) after 1m0s
[17:33:04.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:67:0)
[17:33:04.638] Timer tick, asking Buildbucket for the build status
[17:33:05.164] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:05.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:68:0) after 1m0s
[17:34:05.339] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:68:0)
[17:34:05.339] Timer tick, asking Buildbucket for the build status
[17:34:05.478] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:05.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:69:0) after 1m0s
[17:35:05.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:69:0)
[17:35:05.664] Timer tick, asking Buildbucket for the build status
[17:35:05.849] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:05.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:70:0) after 1m0s
[17:36:06.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:70:0)
[17:36:06.015] Timer tick, asking Buildbucket for the build status
[17:36:06.764] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:06.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:71:0) after 1m0s
[17:37:06.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:71:0)
[17:37:06.864] Timer tick, asking Buildbucket for the build status
[17:37:07.042] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:07.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:72:0) after 1m0s
[17:38:07.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:72:0)
[17:38:07.154] Timer tick, asking Buildbucket for the build status
[17:38:07.339] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:07.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:73:0) after 1m0s
[17:39:07.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:73:0)
[17:39:07.414] Timer tick, asking Buildbucket for the build status
[17:39:07.619] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:07.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:74:0) after 1m0s
[17:40:07.815] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:74:0)
[17:40:07.815] Timer tick, asking Buildbucket for the build status
[17:40:08.115] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:08.115] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:75:0) after 1m0s
[17:41:08.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:75:0)
[17:41:08.152] Timer tick, asking Buildbucket for the build status
[17:41:08.474] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:08.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:76:0) after 1m0s
[17:42:08.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:76:0)
[17:42:08.502] Timer tick, asking Buildbucket for the build status
[17:42:08.778] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:08.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:77:0) after 1m0s
[17:43:08.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:77:0)
[17:43:08.921] Timer tick, asking Buildbucket for the build status
[17:43:09.203] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:09.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:78:0) after 1m0s
[17:44:09.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:78:0)
[17:44:09.242] Timer tick, asking Buildbucket for the build status
[17:44:09.744] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:09.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:79:0) after 1m0s
[17:45:09.791] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:79:0)
[17:45:09.791] Timer tick, asking Buildbucket for the build status
[17:45:10.483] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:10.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:80:0) after 1m0s
[17:46:10.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:80:0)
[17:46:10.794] Timer tick, asking Buildbucket for the build status
[17:46:11.195] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:11.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:81:0) after 1m0s
[17:47:11.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:81:0)
[17:47:11.343] Timer tick, asking Buildbucket for the build status
[17:47:11.530] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:11.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:82:0) after 1m0s
[17:48:11.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:82:0)
[17:48:11.729] Timer tick, asking Buildbucket for the build status
[17:48:12.302] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:12.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:83:0) after 1m0s
[17:49:12.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:83:0)
[17:49:12.451] Timer tick, asking Buildbucket for the build status
[17:49:12.647] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:12.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:84:0) after 1m0s
[17:50:12.640] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:84:0)
[17:50:12.640] Timer tick, asking Buildbucket for the build status
[17:50:12.772] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:12.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:85:0) after 1m0s
[17:51:12.863] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:85:0)
[17:51:12.863] Timer tick, asking Buildbucket for the build status
[17:51:13.108] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:13.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:86:0) after 1m0s
[17:52:13.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:86:0)
[17:52:13.222] Timer tick, asking Buildbucket for the build status
[17:52:13.383] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:13.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:87:0) after 1m0s
[17:53:13.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:87:0)
[17:53:13.508] Timer tick, asking Buildbucket for the build status
[17:53:13.681] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:13.681] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:88:0) after 1m0s
[17:54:13.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:88:0)
[17:54:13.722] Timer tick, asking Buildbucket for the build status
[17:54:13.841] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:13.841] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:89:0) after 1m0s
[17:55:13.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:89:0)
[17:55:13.917] Timer tick, asking Buildbucket for the build status
[17:55:14.120] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:14.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:90:0) after 1m0s
[17:56:14.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:90:0)
[17:56:14.205] Timer tick, asking Buildbucket for the build status
[17:56:16.347] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:16.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:91:0) after 1m0s
[17:57:16.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:91:0)
[17:57:16.761] Timer tick, asking Buildbucket for the build status
[17:57:16.973] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:16.973] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:92:0) after 1m0s
[17:58:17.406] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:92:0)
[17:58:17.406] Timer tick, asking Buildbucket for the build status
[17:58:17.715] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:17.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:93:0) after 1m0s
[17:59:17.997] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:93:0)
[17:59:17.997] Timer tick, asking Buildbucket for the build status
[17:59:18.556] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:18.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:94:0) after 1m0s
[18:00:18.938] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:94:0)
[18:00:18.938] Timer tick, asking Buildbucket for the build status
[18:00:19.076] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:19.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:95:0) after 1m0s
[18:01:19.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:95:0)
[18:01:19.205] Timer tick, asking Buildbucket for the build status
[18:01:19.509] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:19.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:96:0) after 1m0s
[18:02:19.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:96:0)
[18:02:19.799] Timer tick, asking Buildbucket for the build status
[18:02:19.985] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:19.986] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:97:0) after 1m0s
[18:03:20.182] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:97:0)
[18:03:20.182] Timer tick, asking Buildbucket for the build status
[18:03:20.773] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:20.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:98:0) after 1m0s
[18:04:20.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:98:0)
[18:04:20.986] Timer tick, asking Buildbucket for the build status
[18:04:21.216] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:21.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:99:0) after 1m0s
[18:05:21.270] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:99:0)
[18:05:21.270] Timer tick, asking Buildbucket for the build status
[18:05:22.675] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:22.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:100:0) after 1m0s
[18:06:22.842] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:100:0)
[18:06:22.842] Timer tick, asking Buildbucket for the build status
[18:06:23.938] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:23.938] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:101:0) after 1m0s
[18:07:24.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:101:0)
[18:07:24.139] Timer tick, asking Buildbucket for the build status
[18:07:24.884] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:24.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:102:0) after 1m0s
[18:08:24.952] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:102:0)
[18:08:24.952] Timer tick, asking Buildbucket for the build status
[18:08:25.350] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:25.350] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:103:0) after 1m0s
[18:09:25.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:103:0)
[18:09:25.460] Timer tick, asking Buildbucket for the build status
[18:09:25.871] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:25.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:104:0) after 1m0s
[18:10:25.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:104:0)
[18:10:25.884] Timer tick, asking Buildbucket for the build status
[18:10:26.032] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:26.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:105:0) after 1m0s
[18:11:26.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:105:0)
[18:11:26.123] Timer tick, asking Buildbucket for the build status
[18:11:26.978] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:26.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:106:0) after 1m0s
[18:12:27.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:106:0)
[18:12:27.063] Timer tick, asking Buildbucket for the build status
[18:12:27.605] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:27.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:107:0) after 1m0s
[18:13:27.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:107:0)
[18:13:27.706] Timer tick, asking Buildbucket for the build status
[18:13:28.261] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:28.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:108:0) after 1m0s
[18:14:28.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:108:0)
[18:14:28.368] Timer tick, asking Buildbucket for the build status
[18:14:28.524] Build 8889731889778534240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:28.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9055161955311041504:109:0) after 1m0s
[18:14:47.296] Received PubSub notification, asking Buildbucket for the build status
[18:14:47.410] Build 8889731889778534240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:14:47.410] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1580494486561168",
"created_by": "project:chromium",
"created_ts": "1580488039188654",
"id": "8889731889778534240",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d62cf5dae568d470e96839d3227e0b48d7ee98ca\"}}",
"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-32-3-0lnx\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 14636, \"got_angle_revision\": \"5de415c5e3f9616298f0d99d2f618e211870a8f2\", \"got_dawn_revision\": \"f44a809f9a3b6506df5cc1105198ed136c6b26ec\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d62cf5dae568d470e96839d3227e0b48d7ee98ca\", \"got_revision_cp\": \"refs/heads/master@{#737345}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"79b36b640692e3b4561642c06ec36a9e02a1636c\", \"got_v8_revision\": \"a4dcd39d521d14c4b1cac020812e44ee04a7f244\", \"got_v8_revision_cp\": \"refs/heads/8.1.307@{#1}\", \"got_webrtc_revision\": \"bfe3ef8feb3b4e351403be38fe626df4e796648c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30435}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d62cf5dae568d470e96839d3227e0b48d7ee98ca\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-3-0lnx\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4804-5c544e0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580488043697924",
"status": "COMPLETED",
"status_changed_ts": "1580494486876038",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/14636",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/d62cf5dae568d470e96839d3227e0b48d7ee98ca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d62cf5dae568d470e96839d3227e0b48d7ee98ca",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055161955311041504",
"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/8889731889778534240/+/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:4a153f25e3236610",
"user_agent:luci-scheduler"
],
"updated_ts": "1580494486879277",
"url": "https://ci.chromium.org/b/8889731889778534240",
"utcnow_ts": "1580494487400795"
}
}
[18:14:47.410] Invocation finished in 1h47m32.881215971s with status SUCCEEDED