[13:43:46.864] New invocation is queued and will start shortly
[13:43:48.025] Starting the invocation (attempt 1)
[13:43:48.098] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:43:48.098] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:43:48.098] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076190735614549216",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"7d7506d6933478dbcb9dfc993fbbe229b18b37c9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9076190735614549216",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/7d7506d6933478dbcb9dfc993fbbe229b18b37c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d7506d6933478dbcb9dfc993fbbe229b18b37c9",
"gitiles_ref:refs/heads/master"
]
}
[13:43:49.616] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1560433428886533",
"id": "8910760672830736800",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7d7506d6933478dbcb9dfc993fbbe229b18b37c9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560433429422379",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23714",
"builder:Deterministic Linux",
"buildset:commit/git/7d7506d6933478dbcb9dfc993fbbe229b18b37c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d7506d6933478dbcb9dfc993fbbe229b18b37c9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076190735614549216",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8910760672830736800/+/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": "1560433429422473",
"url": "https://ci.chromium.org/b/8910760672830736800",
"utcnow_ts": "1560433429590279"
}
}
[13:43:49.616] Task URL: https://ci.chromium.org/b/8910760672830736800
[13:43:49.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:2:0) after 1m0s
[13:44:29.417] Received PubSub notification, asking Buildbucket for the build status
[13:44:29.553] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:49.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:2:0)
[13:44:49.617] Timer tick, asking Buildbucket for the build status
[13:44:49.820] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:49.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:4:0) after 1m0s
[13:45:49.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:4:0)
[13:45:49.897] Timer tick, asking Buildbucket for the build status
[13:45:50.291] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:50.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:5:0) after 1m0s
[13:46:50.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:5:0)
[13:46:50.342] Timer tick, asking Buildbucket for the build status
[13:46:50.698] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:50.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:6:0) after 1m0s
[13:47:50.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:6:0)
[13:47:50.810] Timer tick, asking Buildbucket for the build status
[13:47:51.143] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:51.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:7:0) after 1m0s
[13:48:51.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:7:0)
[13:48:51.228] Timer tick, asking Buildbucket for the build status
[13:48:51.390] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:51.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:8:0) after 1m0s
[13:49:51.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:8:0)
[13:49:51.542] Timer tick, asking Buildbucket for the build status
[13:49:51.887] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:51.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:9:0) after 1m0s
[13:50:52.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:9:0)
[13:50:52.064] Timer tick, asking Buildbucket for the build status
[13:50:52.923] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:52.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:10:0) after 1m0s
[13:51:53.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:10:0)
[13:51:53.076] Timer tick, asking Buildbucket for the build status
[13:51:55.270] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:55.270] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:11:0) after 1m0s
[13:52:55.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:11:0)
[13:52:55.344] Timer tick, asking Buildbucket for the build status
[13:52:55.522] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:55.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:12:0) after 1m0s
[13:53:55.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:12:0)
[13:53:55.683] Timer tick, asking Buildbucket for the build status
[13:53:58.504] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:58.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:13:0) after 1m0s
[13:54:58.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:13:0)
[13:54:58.508] Timer tick, asking Buildbucket for the build status
[13:54:58.670] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:58.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:14:0) after 1m0s
[13:55:58.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:14:0)
[13:55:58.736] Timer tick, asking Buildbucket for the build status
[13:55:58.828] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:58.828] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:15:0) after 1m0s
[13:56:58.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:15:0)
[13:56:58.913] Timer tick, asking Buildbucket for the build status
[13:56:59.240] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:59.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:16:0) after 1m0s
[13:57:59.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:16:0)
[13:57:59.335] Timer tick, asking Buildbucket for the build status
[13:57:59.822] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:59.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:17:0) after 1m0s
[13:58:59.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:17:0)
[13:58:59.874] Timer tick, asking Buildbucket for the build status
[13:59:00.210] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:00.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:18:0) after 1m0s
[14:00:00.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:18:0)
[14:00:00.258] Timer tick, asking Buildbucket for the build status
[14:00:00.625] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:00.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:19:0) after 1m0s
[14:01:00.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:19:0)
[14:01:00.649] Timer tick, asking Buildbucket for the build status
[14:01:01.591] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:01.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:20:0) after 1m0s
[14:02:01.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:20:0)
[14:02:01.653] Timer tick, asking Buildbucket for the build status
[14:02:04.172] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:04.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:21:0) after 1m0s
[14:03:04.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:21:0)
[14:03:04.210] Timer tick, asking Buildbucket for the build status
[14:03:04.429] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:04.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:22:0) after 1m0s
[14:04:04.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:22:0)
[14:04:04.507] Timer tick, asking Buildbucket for the build status
[14:04:04.670] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:04.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:23:0) after 1m0s
[14:05:04.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:23:0)
[14:05:04.700] Timer tick, asking Buildbucket for the build status
[14:05:05.877] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:05.877] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:24:0) after 1m0s
[14:06:05.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:24:0)
[14:06:05.864] Timer tick, asking Buildbucket for the build status
[14:06:07.203] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:07.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:25:0) after 1m0s
[14:07:07.309] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:25:0)
[14:07:07.309] Timer tick, asking Buildbucket for the build status
[14:07:07.418] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:07.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:26:0) after 1m0s
[14:08:07.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:26:0)
[14:08:07.569] Timer tick, asking Buildbucket for the build status
[14:08:09.341] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:09.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:27:0) after 1m0s
[14:09:09.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:27:0)
[14:09:09.399] Timer tick, asking Buildbucket for the build status
[14:09:09.534] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:09.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:28:0) after 1m0s
[14:10:09.615] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:28:0)
[14:10:09.615] Timer tick, asking Buildbucket for the build status
[14:10:09.728] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:09.728] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:29:0) after 1m0s
[14:11:09.779] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:29:0)
[14:11:09.779] Timer tick, asking Buildbucket for the build status
[14:11:10.021] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:10.021] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:30:0) after 1m0s
[14:12:10.114] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:30:0)
[14:12:10.114] Timer tick, asking Buildbucket for the build status
[14:12:10.891] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:10.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:31:0) after 1m0s
[14:13:11.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:31:0)
[14:13:11.013] Timer tick, asking Buildbucket for the build status
[14:13:11.161] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:11.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:32:0) after 1m0s
[14:14:11.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:32:0)
[14:14:11.185] Timer tick, asking Buildbucket for the build status
[14:14:12.681] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:12.681] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:33:0) after 1m0s
[14:15:12.805] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:33:0)
[14:15:12.805] Timer tick, asking Buildbucket for the build status
[14:15:13.459] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:13.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:34:0) after 1m0s
[14:16:13.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:34:0)
[14:16:13.454] Timer tick, asking Buildbucket for the build status
[14:16:15.738] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:15.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:35:0) after 1m0s
[14:17:15.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:35:0)
[14:17:15.848] Timer tick, asking Buildbucket for the build status
[14:17:16.031] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:16.031] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:36:0) after 1m0s
[14:18:16.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:36:0)
[14:18:16.264] Timer tick, asking Buildbucket for the build status
[14:18:16.982] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:16.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:37:0) after 1m0s
[14:19:17.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:37:0)
[14:19:17.076] Timer tick, asking Buildbucket for the build status
[14:19:17.688] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:17.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:38:0) after 1m0s
[14:20:17.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:38:0)
[14:20:17.817] Timer tick, asking Buildbucket for the build status
[14:20:18.069] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:18.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:39:0) after 1m0s
[14:21:18.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:39:0)
[14:21:18.154] Timer tick, asking Buildbucket for the build status
[14:21:18.368] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:18.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:40:0) after 1m0s
[14:22:18.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:40:0)
[14:22:18.522] Timer tick, asking Buildbucket for the build status
[14:22:18.679] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:18.679] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:41:0) after 1m0s
[14:23:18.703] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:41:0)
[14:23:18.703] Timer tick, asking Buildbucket for the build status
[14:23:19.428] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:19.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:42:0) after 1m0s
[14:24:19.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:42:0)
[14:24:19.601] Timer tick, asking Buildbucket for the build status
[14:24:19.959] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:19.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:43:0) after 1m0s
[14:25:19.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:43:0)
[14:25:19.990] Timer tick, asking Buildbucket for the build status
[14:25:20.251] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:20.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:44:0) after 1m0s
[14:26:20.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:44:0)
[14:26:20.334] Timer tick, asking Buildbucket for the build status
[14:26:20.845] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:20.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:45:0) after 1m0s
[14:27:20.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:45:0)
[14:27:20.894] Timer tick, asking Buildbucket for the build status
[14:27:21.608] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:21.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:46:0) after 1m0s
[14:28:21.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:46:0)
[14:28:21.816] Timer tick, asking Buildbucket for the build status
[14:28:23.549] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:23.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:47:0) after 1m0s
[14:29:23.636] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:47:0)
[14:29:23.636] Timer tick, asking Buildbucket for the build status
[14:29:23.753] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:23.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:48:0) after 1m0s
[14:30:23.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:48:0)
[14:30:23.897] Timer tick, asking Buildbucket for the build status
[14:30:24.373] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:24.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:49:0) after 1m0s
[14:31:24.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:49:0)
[14:31:24.402] Timer tick, asking Buildbucket for the build status
[14:31:25.274] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:25.274] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:50:0) after 1m0s
[14:32:25.397] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:50:0)
[14:32:25.397] Timer tick, asking Buildbucket for the build status
[14:32:25.816] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:25.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:51:0) after 1m0s
[14:33:25.849] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:51:0)
[14:33:25.849] Timer tick, asking Buildbucket for the build status
[14:33:26.211] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:26.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:52:0) after 1m0s
[14:34:26.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:52:0)
[14:34:26.210] Timer tick, asking Buildbucket for the build status
[14:34:27.529] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:27.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:53:0) after 1m0s
[14:35:27.928] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:53:0)
[14:35:27.928] Timer tick, asking Buildbucket for the build status
[14:35:28.065] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:28.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:54:0) after 1m0s
[14:36:28.225] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:54:0)
[14:36:28.225] Timer tick, asking Buildbucket for the build status
[14:36:28.386] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:28.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:55:0) after 1m0s
[14:37:28.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:55:0)
[14:37:28.515] Timer tick, asking Buildbucket for the build status
[14:37:28.857] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:28.857] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:56:0) after 1m0s
[14:38:28.931] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:56:0)
[14:38:28.931] Timer tick, asking Buildbucket for the build status
[14:38:29.038] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:29.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:57:0) after 1m0s
[14:39:29.165] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:57:0)
[14:39:29.165] Timer tick, asking Buildbucket for the build status
[14:39:29.627] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:29.627] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:58:0) after 1m0s
[14:40:30.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:58:0)
[14:40:30.161] Timer tick, asking Buildbucket for the build status
[14:40:30.490] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:30.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:59:0) after 1m0s
[14:41:30.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:59:0)
[14:41:30.647] Timer tick, asking Buildbucket for the build status
[14:41:30.765] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:30.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:60:0) after 1m0s
[14:42:30.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:60:0)
[14:42:30.762] Timer tick, asking Buildbucket for the build status
[14:42:31.067] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:31.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:61:0) after 1m0s
[14:43:31.258] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:61:0)
[14:43:31.258] Timer tick, asking Buildbucket for the build status
[14:43:31.502] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:31.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:62:0) after 1m0s
[14:44:31.628] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:62:0)
[14:44:31.628] Timer tick, asking Buildbucket for the build status
[14:44:31.829] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:31.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:63:0) after 1m0s
[14:45:31.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:63:0)
[14:45:31.917] Timer tick, asking Buildbucket for the build status
[14:45:32.068] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:32.068] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:64:0) after 1m0s
[14:46:32.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:64:0)
[14:46:32.192] Timer tick, asking Buildbucket for the build status
[14:46:32.682] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:32.682] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:65:0) after 1m0s
[14:47:32.976] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:65:0)
[14:47:32.976] Timer tick, asking Buildbucket for the build status
[14:47:33.222] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:33.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:66:0) after 1m0s
[14:48:33.305] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:66:0)
[14:48:33.305] Timer tick, asking Buildbucket for the build status
[14:48:33.663] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:33.663] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:67:0) after 1m0s
[14:49:33.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:67:0)
[14:49:33.707] Timer tick, asking Buildbucket for the build status
[14:49:33.892] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:33.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:68:0) after 1m0s
[14:50:33.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:68:0)
[14:50:33.951] Timer tick, asking Buildbucket for the build status
[14:50:34.111] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:34.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:69:0) after 1m0s
[14:51:34.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:69:0)
[14:51:34.290] Timer tick, asking Buildbucket for the build status
[14:51:34.447] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:34.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:70:0) after 1m0s
[14:52:34.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:70:0)
[14:52:34.497] Timer tick, asking Buildbucket for the build status
[14:52:34.613] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:34.613] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:71:0) after 1m0s
[14:53:34.746] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:71:0)
[14:53:34.746] Timer tick, asking Buildbucket for the build status
[14:53:34.916] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:34.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:72:0) after 1m0s
[14:54:34.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:72:0)
[14:54:34.967] Timer tick, asking Buildbucket for the build status
[14:54:35.322] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:35.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:73:0) after 1m0s
[14:55:35.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:73:0)
[14:55:35.395] Timer tick, asking Buildbucket for the build status
[14:55:35.570] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:35.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:74:0) after 1m0s
[14:56:35.651] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:74:0)
[14:56:35.651] Timer tick, asking Buildbucket for the build status
[14:56:37.069] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:37.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:75:0) after 1m0s
[14:57:37.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:75:0)
[14:57:37.144] Timer tick, asking Buildbucket for the build status
[14:57:37.246] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:37.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:76:0) after 1m0s
[14:58:37.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:76:0)
[14:58:37.392] Timer tick, asking Buildbucket for the build status
[14:58:38.390] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:38.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:77:0) after 1m0s
[14:59:38.475] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:77:0)
[14:59:38.475] Timer tick, asking Buildbucket for the build status
[14:59:38.610] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:38.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:78:0) after 1m0s
[15:00:38.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:78:0)
[15:00:38.729] Timer tick, asking Buildbucket for the build status
[15:00:39.220] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:39.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:79:0) after 1m0s
[15:01:39.291] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:79:0)
[15:01:39.291] Timer tick, asking Buildbucket for the build status
[15:01:40.394] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:40.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:80:0) after 1m0s
[15:02:40.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:80:0)
[15:02:40.586] Timer tick, asking Buildbucket for the build status
[15:02:40.815] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:40.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:81:0) after 1m0s
[15:03:40.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:81:0)
[15:03:40.898] Timer tick, asking Buildbucket for the build status
[15:03:41.926] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:41.926] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:82:0) after 1m0s
[15:04:42.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:82:0)
[15:04:42.186] Timer tick, asking Buildbucket for the build status
[15:04:42.409] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:42.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:83:0) after 1m0s
[15:05:42.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:83:0)
[15:05:42.515] Timer tick, asking Buildbucket for the build status
[15:05:42.684] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:42.685] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:84:0) after 1m0s
[15:06:43.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:84:0)
[15:06:43.152] Timer tick, asking Buildbucket for the build status
[15:06:44.463] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:44.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:85:0) after 1m0s
[15:07:44.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:85:0)
[15:07:44.579] Timer tick, asking Buildbucket for the build status
[15:07:45.393] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:45.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:86:0) after 1m0s
[15:08:45.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:86:0)
[15:08:45.601] Timer tick, asking Buildbucket for the build status
[15:08:46.033] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:46.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:87:0) after 1m0s
[15:09:46.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:87:0)
[15:09:46.094] Timer tick, asking Buildbucket for the build status
[15:09:46.215] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:46.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:88:0) after 1m0s
[15:10:46.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:88:0)
[15:10:46.286] Timer tick, asking Buildbucket for the build status
[15:10:47.049] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:47.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:89:0) after 1m0s
[15:11:47.125] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:89:0)
[15:11:47.125] Timer tick, asking Buildbucket for the build status
[15:11:47.225] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:47.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:90:0) after 1m0s
[15:12:47.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:90:0)
[15:12:47.321] Timer tick, asking Buildbucket for the build status
[15:12:48.271] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:48.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:91:0) after 1m0s
[15:13:48.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:91:0)
[15:13:48.288] Timer tick, asking Buildbucket for the build status
[15:13:49.852] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:49.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:92:0) after 1m0s
[15:14:49.892] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:92:0)
[15:14:49.892] Timer tick, asking Buildbucket for the build status
[15:14:50.088] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:50.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:93:0) after 1m0s
[15:15:50.080] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:93:0)
[15:15:50.080] Timer tick, asking Buildbucket for the build status
[15:15:50.802] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:50.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:94:0) after 1m0s
[15:16:50.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:94:0)
[15:16:50.860] Timer tick, asking Buildbucket for the build status
[15:16:51.164] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:51.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:95:0) after 1m0s
[15:17:51.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:95:0)
[15:17:51.220] Timer tick, asking Buildbucket for the build status
[15:17:51.429] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:51.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:96:0) after 1m0s
[15:18:51.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:96:0)
[15:18:51.436] Timer tick, asking Buildbucket for the build status
[15:18:51.942] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:51.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:97:0) after 1m0s
[15:19:52.109] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:97:0)
[15:19:52.109] Timer tick, asking Buildbucket for the build status
[15:19:54.530] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:54.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:98:0) after 1m0s
[15:20:54.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:98:0)
[15:20:54.597] Timer tick, asking Buildbucket for the build status
[15:20:54.696] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:54.696] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:99:0) after 1m0s
[15:21:54.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:99:0)
[15:21:54.724] Timer tick, asking Buildbucket for the build status
[15:21:54.836] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:54.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:100:0) after 1m0s
[15:22:54.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:100:0)
[15:22:54.819] Timer tick, asking Buildbucket for the build status
[15:22:57.285] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:57.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:101:0) after 1m0s
[15:23:57.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:101:0)
[15:23:57.338] Timer tick, asking Buildbucket for the build status
[15:23:59.243] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:59.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:102:0) after 1m0s
[15:24:59.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:102:0)
[15:24:59.282] Timer tick, asking Buildbucket for the build status
[15:24:59.375] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:59.375] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:103:0) after 1m0s
[15:25:59.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:103:0)
[15:25:59.466] Timer tick, asking Buildbucket for the build status
[15:25:59.804] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:59.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:104:0) after 1m0s
[15:26:59.849] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:104:0)
[15:26:59.849] Timer tick, asking Buildbucket for the build status
[15:26:59.954] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:59.954] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:105:0) after 1m0s
[15:27:59.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:105:0)
[15:27:59.987] Timer tick, asking Buildbucket for the build status
[15:28:00.470] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:00.470] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:106:0) after 1m0s
[15:29:00.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:106:0)
[15:29:00.603] Timer tick, asking Buildbucket for the build status
[15:29:00.889] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:00.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:107:0) after 1m0s
[15:30:00.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:107:0)
[15:30:00.925] Timer tick, asking Buildbucket for the build status
[15:30:01.601] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:01.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:108:0) after 1m0s
[15:31:01.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:108:0)
[15:31:01.659] Timer tick, asking Buildbucket for the build status
[15:31:01.753] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:01.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:109:0) after 1m0s
[15:32:01.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:109:0)
[15:32:01.788] Timer tick, asking Buildbucket for the build status
[15:32:02.065] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:02.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:110:0) after 1m0s
[15:33:02.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:110:0)
[15:33:02.113] Timer tick, asking Buildbucket for the build status
[15:33:03.093] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:03.093] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:111:0) after 1m0s
[15:34:03.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:111:0)
[15:34:03.148] Timer tick, asking Buildbucket for the build status
[15:34:04.519] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:04.519] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:112:0) after 1m0s
[15:35:04.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:112:0)
[15:35:04.540] Timer tick, asking Buildbucket for the build status
[15:35:06.491] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:06.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:113:0) after 1m0s
[15:36:06.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:113:0)
[15:36:06.579] Timer tick, asking Buildbucket for the build status
[15:36:07.456] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:07.456] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:114:0) after 1m0s
[15:37:07.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:114:0)
[15:37:07.510] Timer tick, asking Buildbucket for the build status
[15:37:09.058] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:09.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:115:0) after 1m0s
[15:38:09.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:115:0)
[15:38:09.066] Timer tick, asking Buildbucket for the build status
[15:38:09.392] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:09.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:116:0) after 1m0s
[15:39:09.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:116:0)
[15:39:09.526] Timer tick, asking Buildbucket for the build status
[15:39:09.624] Build 8910760672830736800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:09.624] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076190735614549216:117:0) after 1m0s
[15:39:14.850] Received PubSub notification, asking Buildbucket for the build status
[15:39:15.003] Build 8910760672830736800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:39:15.003] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1560440353597808",
"created_by": "project:chromium",
"created_ts": "1560433428886533",
"id": "8910760672830736800",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7d7506d6933478dbcb9dfc993fbbe229b18b37c9\"}}",
"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-trusty-8-7-0wse\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 23714, \"got_angle_revision\": \"d187d45ede29369025595c53c7fe3ffed0688870\", \"got_dawn_revision\": \"df69f2482462a870adeb89fb2dd91f5acd992c1e\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"7d7506d6933478dbcb9dfc993fbbe229b18b37c9\", \"got_revision_cp\": \"refs/heads/master@{#668806}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"e619ed57592ca2e2a69ab8fe2c463c810e8a7bc0\", \"got_v8_revision_cp\": \"refs/heads/7.7.64@{#1}\", \"got_webrtc_revision\": \"35c26284a9e170127f39492768a74f4b93833806\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28260}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7d7506d6933478dbcb9dfc993fbbe229b18b37c9\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5962259a05f00f2add6b886e805611a7d5779224d38d219d9f2179a6416f230e_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-8-7-0wse\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4339-6285c57\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1560433468275431",
"status": "COMPLETED",
"status_changed_ts": "1560440353789229",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23714",
"builder:Deterministic Linux",
"buildset:commit/git/7d7506d6933478dbcb9dfc993fbbe229b18b37c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d7506d6933478dbcb9dfc993fbbe229b18b37c9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076190735614549216",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8910760672830736800/+/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:4569e61828ab9210",
"user_agent:luci-scheduler"
],
"updated_ts": "1560440353792582",
"url": "https://ci.chromium.org/b/8910760672830736800",
"utcnow_ts": "1560440354993942"
}
}
[15:39:15.003] Invocation finished in 1h55m28.155713675s with status SUCCEEDED