[15:42:50.375] New invocation is queued and will start shortly
[15:42:51.794] Starting the invocation (attempt 1)
[15:42:51.845] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:42:51.845] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:42:51.845] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056523703403189888",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"35afdcdd5fe9b766b94633cbd1afbf4b20164285\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9056523703403189888",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/35afdcdd5fe9b766b94633cbd1afbf4b20164285",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35afdcdd5fe9b766b94633cbd1afbf4b20164285",
"gitiles_ref:refs/heads/master"
]
}
[15:42:53.044] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579189372018266",
"id": "8891093641005145232",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35afdcdd5fe9b766b94633cbd1afbf4b20164285\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579189372690055",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/14309",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/35afdcdd5fe9b766b94633cbd1afbf4b20164285",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35afdcdd5fe9b766b94633cbd1afbf4b20164285",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056523703403189888",
"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/8891093641005145232/+/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": "1579189372690186",
"url": "https://ci.chromium.org/b/8891093641005145232",
"utcnow_ts": "1579189373036024"
}
}
[15:42:53.044] Task URL: https://ci.chromium.org/b/8891093641005145232
[15:42:53.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:2:0) after 1m0s
[15:42:59.206] Received PubSub notification, asking Buildbucket for the build status
[15:42:59.319] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:53.214] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:2:0)
[15:43:53.214] Timer tick, asking Buildbucket for the build status
[15:43:53.398] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:53.398] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:4:0) after 1m0s
[15:44:53.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:4:0)
[15:44:53.429] Timer tick, asking Buildbucket for the build status
[15:44:54.081] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:54.081] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:5:0) after 1m0s
[15:45:54.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:5:0)
[15:45:54.221] Timer tick, asking Buildbucket for the build status
[15:45:54.404] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:54.404] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:6:0) after 1m0s
[15:46:54.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:6:0)
[15:46:54.408] Timer tick, asking Buildbucket for the build status
[15:46:54.674] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:54.674] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:7:0) after 1m0s
[15:47:54.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:7:0)
[15:47:54.711] Timer tick, asking Buildbucket for the build status
[15:47:54.824] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:54.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:8:0) after 1m0s
[15:48:54.847] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:8:0)
[15:48:54.847] Timer tick, asking Buildbucket for the build status
[15:48:55.002] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:55.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:9:0) after 1m0s
[15:49:55.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:9:0)
[15:49:55.059] Timer tick, asking Buildbucket for the build status
[15:49:55.846] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:55.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:10:0) after 1m0s
[15:50:55.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:10:0)
[15:50:55.919] Timer tick, asking Buildbucket for the build status
[15:50:56.067] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:56.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:11:0) after 1m0s
[15:51:56.095] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:11:0)
[15:51:56.095] Timer tick, asking Buildbucket for the build status
[15:51:56.279] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:56.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:12:0) after 1m0s
[15:52:56.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:12:0)
[15:52:56.391] Timer tick, asking Buildbucket for the build status
[15:52:57.161] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:57.161] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:13:0) after 1m0s
[15:53:57.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:13:0)
[15:53:57.407] Timer tick, asking Buildbucket for the build status
[15:53:57.975] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:57.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:14:0) after 1m0s
[15:54:58.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:14:0)
[15:54:58.011] Timer tick, asking Buildbucket for the build status
[15:54:59.079] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:59.079] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:15:0) after 1m0s
[15:55:59.107] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:15:0)
[15:55:59.107] Timer tick, asking Buildbucket for the build status
[15:55:59.275] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:59.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:16:0) after 1m0s
[15:56:59.348] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:16:0)
[15:56:59.348] Timer tick, asking Buildbucket for the build status
[15:56:59.518] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:59.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:17:0) after 1m0s
[15:57:59.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:17:0)
[15:57:59.658] Timer tick, asking Buildbucket for the build status
[15:57:59.855] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:59.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:18:0) after 1m0s
[15:58:59.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:18:0)
[15:58:59.881] Timer tick, asking Buildbucket for the build status
[15:59:00.281] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:00.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:19:0) after 1m0s
[16:00:00.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:19:0)
[16:00:00.496] Timer tick, asking Buildbucket for the build status
[16:00:01.303] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:01.303] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:20:0) after 1m0s
[16:01:01.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:20:0)
[16:01:01.350] Timer tick, asking Buildbucket for the build status
[16:01:02.359] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:02.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:21:0) after 1m0s
[16:02:02.396] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:21:0)
[16:02:02.396] Timer tick, asking Buildbucket for the build status
[16:02:02.542] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:02.542] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:22:0) after 1m0s
[16:03:02.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:22:0)
[16:03:02.578] Timer tick, asking Buildbucket for the build status
[16:03:02.706] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:02.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:23:0) after 1m0s
[16:04:02.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:23:0)
[16:04:02.990] Timer tick, asking Buildbucket for the build status
[16:04:04.431] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:04.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:24:0) after 1m0s
[16:05:04.566] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:24:0)
[16:05:04.566] Timer tick, asking Buildbucket for the build status
[16:05:06.601] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:06.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:25:0) after 1m0s
[16:06:06.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:25:0)
[16:06:06.750] Timer tick, asking Buildbucket for the build status
[16:06:07.151] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:07.151] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:26:0) after 1m0s
[16:07:07.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:26:0)
[16:07:07.176] Timer tick, asking Buildbucket for the build status
[16:07:07.437] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:07.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:27:0) after 1m0s
[16:08:07.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:27:0)
[16:08:07.516] Timer tick, asking Buildbucket for the build status
[16:08:07.721] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:07.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:28:0) after 1m0s
[16:09:07.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:28:0)
[16:09:07.750] Timer tick, asking Buildbucket for the build status
[16:09:07.883] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:07.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:29:0) after 1m0s
[16:10:07.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:29:0)
[16:10:07.948] Timer tick, asking Buildbucket for the build status
[16:10:08.135] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:08.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:30:0) after 1m0s
[16:11:08.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:30:0)
[16:11:08.283] Timer tick, asking Buildbucket for the build status
[16:11:09.074] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:09.074] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:31:0) after 1m0s
[16:12:09.136] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:31:0)
[16:12:09.136] Timer tick, asking Buildbucket for the build status
[16:12:09.719] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:09.719] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:32:0) after 1m0s
[16:13:09.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:32:0)
[16:13:09.816] Timer tick, asking Buildbucket for the build status
[16:13:09.970] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:09.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:33:0) after 1m0s
[16:14:10.010] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:33:0)
[16:14:10.010] Timer tick, asking Buildbucket for the build status
[16:14:12.281] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:12.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:34:0) after 1m0s
[16:15:12.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:34:0)
[16:15:12.302] Timer tick, asking Buildbucket for the build status
[16:15:14.129] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:14.129] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:35:0) after 1m0s
[16:16:14.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:35:0)
[16:16:14.219] Timer tick, asking Buildbucket for the build status
[16:16:14.353] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:14.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:36:0) after 1m0s
[16:17:14.377] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:36:0)
[16:17:14.377] Timer tick, asking Buildbucket for the build status
[16:17:14.570] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:14.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:37:0) after 1m0s
[16:18:14.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:37:0)
[16:18:14.601] Timer tick, asking Buildbucket for the build status
[16:18:15.495] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:15.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:38:0) after 1m0s
[16:19:15.571] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:38:0)
[16:19:15.571] Timer tick, asking Buildbucket for the build status
[16:19:15.695] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:15.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:39:0) after 1m0s
[16:20:15.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:39:0)
[16:20:15.780] Timer tick, asking Buildbucket for the build status
[16:20:16.087] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:40:0) after 1m0s
[16:21:16.098] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:40:0)
[16:21:16.098] Timer tick, asking Buildbucket for the build status
[16:21:16.528] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:16.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:41:0) after 1m0s
[16:22:16.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:41:0)
[16:22:16.573] Timer tick, asking Buildbucket for the build status
[16:22:17.739] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:17.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:42:0) after 1m0s
[16:23:17.836] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:42:0)
[16:23:17.836] Timer tick, asking Buildbucket for the build status
[16:23:18.058] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:18.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:43:0) after 1m0s
[16:24:18.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:43:0)
[16:24:18.128] Timer tick, asking Buildbucket for the build status
[16:24:18.292] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:18.292] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:44:0) after 1m0s
[16:25:18.357] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:44:0)
[16:25:18.357] Timer tick, asking Buildbucket for the build status
[16:25:18.490] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:18.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:45:0) after 1m0s
[16:26:18.533] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:45:0)
[16:26:18.533] Timer tick, asking Buildbucket for the build status
[16:26:19.310] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:19.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:46:0) after 1m0s
[16:27:19.382] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:46:0)
[16:27:19.382] Timer tick, asking Buildbucket for the build status
[16:27:19.619] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:19.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:47:0) after 1m0s
[16:28:19.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:47:0)
[16:28:19.625] Timer tick, asking Buildbucket for the build status
[16:28:20.626] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:20.626] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:48:0) after 1m0s
[16:29:20.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:48:0)
[16:29:20.752] Timer tick, asking Buildbucket for the build status
[16:29:20.935] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:20.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:49:0) after 1m0s
[16:30:20.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:49:0)
[16:30:20.995] Timer tick, asking Buildbucket for the build status
[16:30:21.536] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:21.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:50:0) after 1m0s
[16:31:21.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:50:0)
[16:31:21.603] Timer tick, asking Buildbucket for the build status
[16:31:23.062] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:23.062] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:51:0) after 1m0s
[16:32:23.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:51:0)
[16:32:23.124] Timer tick, asking Buildbucket for the build status
[16:32:23.355] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:23.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:52:0) after 1m0s
[16:33:23.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:52:0)
[16:33:23.449] Timer tick, asking Buildbucket for the build status
[16:33:23.608] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:23.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:53:0) after 1m0s
[16:34:23.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:53:0)
[16:34:23.658] Timer tick, asking Buildbucket for the build status
[16:34:23.827] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:23.827] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:54:0) after 1m0s
[16:35:23.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:54:0)
[16:35:23.866] Timer tick, asking Buildbucket for the build status
[16:35:24.057] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:24.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:55:0) after 1m0s
[16:36:24.107] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:55:0)
[16:36:24.107] Timer tick, asking Buildbucket for the build status
[16:36:24.594] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:24.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:56:0) after 1m0s
[16:37:24.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:56:0)
[16:37:24.622] Timer tick, asking Buildbucket for the build status
[16:37:24.805] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:24.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:57:0) after 1m0s
[16:38:24.828] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:57:0)
[16:38:24.828] Timer tick, asking Buildbucket for the build status
[16:38:25.068] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:25.068] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:58:0) after 1m0s
[16:39:25.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:58:0)
[16:39:25.091] Timer tick, asking Buildbucket for the build status
[16:39:25.236] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:25.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:59:0) after 1m0s
[16:40:25.253] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:59:0)
[16:40:25.253] Timer tick, asking Buildbucket for the build status
[16:40:25.408] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:25.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:60:0) after 1m0s
[16:41:25.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:60:0)
[16:41:25.435] Timer tick, asking Buildbucket for the build status
[16:41:25.569] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:25.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:61:0) after 1m0s
[16:42:25.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:61:0)
[16:42:25.643] Timer tick, asking Buildbucket for the build status
[16:42:25.866] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:25.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:62:0) after 1m0s
[16:43:25.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:62:0)
[16:43:25.936] Timer tick, asking Buildbucket for the build status
[16:43:26.550] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:26.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:63:0) after 1m0s
[16:44:26.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:63:0)
[16:44:26.564] Timer tick, asking Buildbucket for the build status
[16:44:27.411] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:27.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:64:0) after 1m0s
[16:45:27.448] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:64:0)
[16:45:27.448] Timer tick, asking Buildbucket for the build status
[16:45:27.607] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:27.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:65:0) after 1m0s
[16:46:27.770] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:65:0)
[16:46:27.770] Timer tick, asking Buildbucket for the build status
[16:46:27.937] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:27.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:66:0) after 1m0s
[16:47:28.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:66:0)
[16:47:28.058] Timer tick, asking Buildbucket for the build status
[16:47:28.224] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:28.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:67:0) after 1m0s
[16:48:28.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:67:0)
[16:48:28.268] Timer tick, asking Buildbucket for the build status
[16:48:28.531] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:28.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:68:0) after 1m0s
[16:49:28.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:68:0)
[16:49:28.682] Timer tick, asking Buildbucket for the build status
[16:49:29.814] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:29.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:69:0) after 1m0s
[16:50:30.035] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:69:0)
[16:50:30.035] Timer tick, asking Buildbucket for the build status
[16:50:30.577] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:30.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:70:0) after 1m0s
[16:51:30.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:70:0)
[16:51:30.871] Timer tick, asking Buildbucket for the build status
[16:51:31.168] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:31.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:71:0) after 1m0s
[16:52:31.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:71:0)
[16:52:31.352] Timer tick, asking Buildbucket for the build status
[16:52:33.335] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:33.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:72:0) after 1m0s
[16:53:33.353] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:72:0)
[16:53:33.353] Timer tick, asking Buildbucket for the build status
[16:53:33.501] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:33.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:73:0) after 1m0s
[16:54:33.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:73:0)
[16:54:33.555] Timer tick, asking Buildbucket for the build status
[16:54:33.741] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:33.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:74:0) after 1m0s
[16:55:33.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:74:0)
[16:55:33.781] Timer tick, asking Buildbucket for the build status
[16:55:34.083] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:34.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:75:0) after 1m0s
[16:56:34.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:75:0)
[16:56:34.126] Timer tick, asking Buildbucket for the build status
[16:56:34.432] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:34.432] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:76:0) after 1m0s
[16:57:34.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:76:0)
[16:57:34.489] Timer tick, asking Buildbucket for the build status
[16:57:34.653] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:34.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:77:0) after 1m0s
[16:58:34.836] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:77:0)
[16:58:34.836] Timer tick, asking Buildbucket for the build status
[16:58:35.284] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:35.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:78:0) after 1m0s
[16:59:36.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:78:0)
[16:59:36.222] Timer tick, asking Buildbucket for the build status
[16:59:37.252] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:37.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:79:0) after 1m0s
[17:00:37.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:79:0)
[17:00:37.683] Timer tick, asking Buildbucket for the build status
[17:00:38.418] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:38.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:80:0) after 1m0s
[17:01:38.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:80:0)
[17:01:38.467] Timer tick, asking Buildbucket for the build status
[17:01:38.625] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:38.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:81:0) after 1m0s
[17:02:38.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:81:0)
[17:02:38.736] Timer tick, asking Buildbucket for the build status
[17:02:39.121] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:39.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:82:0) after 1m0s
[17:03:39.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:82:0)
[17:03:39.194] Timer tick, asking Buildbucket for the build status
[17:03:39.347] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:39.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:83:0) after 1m0s
[17:04:39.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:83:0)
[17:04:39.370] Timer tick, asking Buildbucket for the build status
[17:04:39.798] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:39.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:84:0) after 1m0s
[17:05:39.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:84:0)
[17:05:39.885] Timer tick, asking Buildbucket for the build status
[17:05:40.707] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:40.707] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:85:0) after 1m0s
[17:06:40.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:85:0)
[17:06:40.816] Timer tick, asking Buildbucket for the build status
[17:06:42.196] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:42.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:86:0) after 1m0s
[17:07:42.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:86:0)
[17:07:42.343] Timer tick, asking Buildbucket for the build status
[17:07:42.821] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:42.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:87:0) after 1m0s
[17:08:42.869] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:87:0)
[17:08:42.869] Timer tick, asking Buildbucket for the build status
[17:08:43.075] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:43.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:88:0) after 1m0s
[17:09:43.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:88:0)
[17:09:43.266] Timer tick, asking Buildbucket for the build status
[17:09:43.468] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:43.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:89:0) after 1m0s
[17:10:43.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:89:0)
[17:10:43.611] Timer tick, asking Buildbucket for the build status
[17:10:44.062] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:44.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:90:0) after 1m0s
[17:11:44.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:90:0)
[17:11:44.137] Timer tick, asking Buildbucket for the build status
[17:11:44.874] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:44.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:91:0) after 1m0s
[17:12:44.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:91:0)
[17:12:44.908] Timer tick, asking Buildbucket for the build status
[17:12:46.781] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:46.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:92:0) after 1m0s
[17:13:46.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:92:0)
[17:13:46.818] Timer tick, asking Buildbucket for the build status
[17:13:47.046] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:47.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:93:0) after 1m0s
[17:14:47.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:93:0)
[17:14:47.111] Timer tick, asking Buildbucket for the build status
[17:14:47.294] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:47.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:94:0) after 1m0s
[17:15:47.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:94:0)
[17:15:47.351] Timer tick, asking Buildbucket for the build status
[17:15:47.503] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:47.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:95:0) after 1m0s
[17:16:47.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:95:0)
[17:16:47.507] Timer tick, asking Buildbucket for the build status
[17:16:47.657] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:96:0) after 1m0s
[17:17:47.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:96:0)
[17:17:47.759] Timer tick, asking Buildbucket for the build status
[17:17:47.900] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:47.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:97:0) after 1m0s
[17:18:47.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:97:0)
[17:18:47.930] Timer tick, asking Buildbucket for the build status
[17:18:49.361] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:49.361] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:98:0) after 1m0s
[17:19:49.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:98:0)
[17:19:49.575] Timer tick, asking Buildbucket for the build status
[17:19:49.777] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:49.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:99:0) after 1m0s
[17:20:49.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:99:0)
[17:20:49.759] Timer tick, asking Buildbucket for the build status
[17:20:50.535] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:50.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:100:0) after 1m0s
[17:21:50.571] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:100:0)
[17:21:50.571] Timer tick, asking Buildbucket for the build status
[17:21:51.251] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:51.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:101:0) after 1m0s
[17:22:51.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:101:0)
[17:22:51.263] Timer tick, asking Buildbucket for the build status
[17:22:51.605] Build 8891093641005145232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:51.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9056523703403189888:102:0) after 1m0s
[17:23:28.953] Received PubSub notification, asking Buildbucket for the build status
[17:23:29.566] Build 8891093641005145232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:23:29.566] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579195408278884",
"created_by": "project:chromium",
"created_ts": "1579189372018266",
"id": "8891093641005145232",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35afdcdd5fe9b766b94633cbd1afbf4b20164285\"}}",
"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-12-dup9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 14309, \"got_angle_revision\": \"0d2c75f4d56a12ca6308e8fb857205de86711657\", \"got_dawn_revision\": \"631f4258a1ace016d6a10ebf7ff127ea46be8575\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"35afdcdd5fe9b766b94633cbd1afbf4b20164285\", \"got_revision_cp\": \"refs/heads/master@{#732401}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"5fc197dc76693d0049d1f400a077f13fa1f6078b\", \"got_v8_revision\": \"849589ecc0d727c36c90abb07cf2338f583834a7\", \"got_v8_revision_cp\": \"refs/heads/8.1.190@{#1}\", \"got_webrtc_revision\": \"6ca908f48c88fda174516ec8edc5041f61a432b2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30277}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35afdcdd5fe9b766b94633cbd1afbf4b20164285\"}, \"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-12-dup9\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579189377851235",
"status": "COMPLETED",
"status_changed_ts": "1579195408718347",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/14309",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/35afdcdd5fe9b766b94633cbd1afbf4b20164285",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35afdcdd5fe9b766b94633cbd1afbf4b20164285",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056523703403189888",
"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/8891093641005145232/+/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:49c7d710caac5c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1579195408722788",
"url": "https://ci.chromium.org/b/8891093641005145232",
"utcnow_ts": "1579195409539905"
}
}
[17:23:29.566] Invocation finished in 1h40m39.219126181s with status SUCCEEDED