[19:48:44.846] New invocation is queued and will start shortly
[19:48:45.945] Starting the invocation (attempt 1)
[19:48:45.980] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:48:45.981] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:48:45.981] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9040653763088884560",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1d831f0788ac200b96f02e08229110de5f9939e9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9040653763088884560",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/1d831f0788ac200b96f02e08229110de5f9939e9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d831f0788ac200b96f02e08229110de5f9939e9",
"gitiles_ref:refs/heads/master"
]
}
[19:48:47.215] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1594324126123342",
"id": "8875223701084773552",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d831f0788ac200b96f02e08229110de5f9939e9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594324126859633",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28494",
"builder:Deterministic Linux",
"buildset:commit/git/1d831f0788ac200b96f02e08229110de5f9939e9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d831f0788ac200b96f02e08229110de5f9939e9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040653763088884560",
"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/8875223701084773552/+/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": "1594324126859883",
"url": "https://ci.chromium.org/b/8875223701084773552",
"utcnow_ts": "1594324127201666"
}
}
[19:48:47.215] Task URL: https://ci.chromium.org/b/8875223701084773552
[19:48:47.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:2:0) after 1m0s
[19:48:52.982] Received PubSub notification, asking Buildbucket for the build status
[19:48:53.064] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:47.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:2:0)
[19:49:47.239] Timer tick, asking Buildbucket for the build status
[19:49:49.106] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:49.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:4:0) after 1m0s
[19:50:49.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:4:0)
[19:50:49.228] Timer tick, asking Buildbucket for the build status
[19:50:49.415] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:49.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:5:0) after 1m0s
[19:51:49.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:5:0)
[19:51:49.457] Timer tick, asking Buildbucket for the build status
[19:51:49.630] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:49.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:6:0) after 1m0s
[19:52:49.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:6:0)
[19:52:49.701] Timer tick, asking Buildbucket for the build status
[19:52:50.706] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:50.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:7:0) after 1m0s
[19:53:50.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:7:0)
[19:53:50.897] Timer tick, asking Buildbucket for the build status
[19:53:51.072] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:51.072] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:8:0) after 1m0s
[19:54:51.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:8:0)
[19:54:51.137] Timer tick, asking Buildbucket for the build status
[19:54:51.384] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:51.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:9:0) after 1m0s
[19:55:51.539] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:9:0)
[19:55:51.539] Timer tick, asking Buildbucket for the build status
[19:55:52.113] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:52.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:10:0) after 1m0s
[19:56:52.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:10:0)
[19:56:52.235] Timer tick, asking Buildbucket for the build status
[19:56:52.623] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:52.623] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:11:0) after 1m0s
[19:57:52.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:11:0)
[19:57:52.666] Timer tick, asking Buildbucket for the build status
[19:57:52.804] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:52.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:12:0) after 1m0s
[19:58:52.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:12:0)
[19:58:52.854] Timer tick, asking Buildbucket for the build status
[19:58:53.062] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:53.062] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:13:0) after 1m0s
[19:59:53.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:13:0)
[19:59:53.105] Timer tick, asking Buildbucket for the build status
[19:59:53.344] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:53.344] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:14:0) after 1m0s
[20:00:53.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:14:0)
[20:00:53.398] Timer tick, asking Buildbucket for the build status
[20:00:53.588] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:53.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:15:0) after 1m0s
[20:01:53.610] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:15:0)
[20:01:53.610] Timer tick, asking Buildbucket for the build status
[20:01:53.763] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:53.763] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:16:0) after 1m0s
[20:02:53.789] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:16:0)
[20:02:53.789] Timer tick, asking Buildbucket for the build status
[20:02:53.926] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:53.926] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:17:0) after 1m0s
[20:03:53.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:17:0)
[20:03:53.929] Timer tick, asking Buildbucket for the build status
[20:03:54.097] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:54.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:18:0) after 1m0s
[20:04:54.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:18:0)
[20:04:54.105] Timer tick, asking Buildbucket for the build status
[20:04:54.300] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:54.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:19:0) after 1m0s
[20:05:54.419] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:19:0)
[20:05:54.419] Timer tick, asking Buildbucket for the build status
[20:05:54.676] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:54.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:20:0) after 1m0s
[20:06:54.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:20:0)
[20:06:54.774] Timer tick, asking Buildbucket for the build status
[20:06:55.247] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:55.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:21:0) after 1m0s
[20:07:55.325] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:21:0)
[20:07:55.325] Timer tick, asking Buildbucket for the build status
[20:07:55.627] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:55.627] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:22:0) after 1m0s
[20:08:55.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:22:0)
[20:08:55.777] Timer tick, asking Buildbucket for the build status
[20:08:55.898] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:55.898] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:23:0) after 1m0s
[20:09:55.926] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:23:0)
[20:09:55.926] Timer tick, asking Buildbucket for the build status
[20:09:56.103] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:56.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:24:0) after 1m0s
[20:10:56.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:24:0)
[20:10:56.262] Timer tick, asking Buildbucket for the build status
[20:10:56.467] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:56.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:25:0) after 1m0s
[20:11:56.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:25:0)
[20:11:56.570] Timer tick, asking Buildbucket for the build status
[20:11:56.710] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:56.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:26:0) after 1m0s
[20:12:56.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:26:0)
[20:12:56.880] Timer tick, asking Buildbucket for the build status
[20:12:57.522] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:57.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:27:0) after 1m0s
[20:13:57.620] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:27:0)
[20:13:57.620] Timer tick, asking Buildbucket for the build status
[20:13:58.969] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:58.969] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:28:0) after 1m0s
[20:14:58.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:28:0)
[20:14:58.968] Timer tick, asking Buildbucket for the build status
[20:14:59.144] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:59.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:29:0) after 1m0s
[20:15:59.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:29:0)
[20:15:59.192] Timer tick, asking Buildbucket for the build status
[20:15:59.616] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:59.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:30:0) after 1m0s
[20:16:59.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:30:0)
[20:16:59.645] Timer tick, asking Buildbucket for the build status
[20:16:59.918] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:59.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:31:0) after 1m0s
[20:17:59.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:31:0)
[20:17:59.970] Timer tick, asking Buildbucket for the build status
[20:18:00.275] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:00.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:32:0) after 1m0s
[20:19:00.417] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:32:0)
[20:19:00.417] Timer tick, asking Buildbucket for the build status
[20:19:02.463] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:02.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:33:0) after 1m0s
[20:20:02.567] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:33:0)
[20:20:02.567] Timer tick, asking Buildbucket for the build status
[20:20:03.560] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:03.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:34:0) after 1m0s
[20:21:03.652] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:34:0)
[20:21:03.652] Timer tick, asking Buildbucket for the build status
[20:21:03.896] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:03.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:35:0) after 1m0s
[20:22:03.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:35:0)
[20:22:03.962] Timer tick, asking Buildbucket for the build status
[20:22:04.204] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:04.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:36:0) after 1m0s
[20:23:04.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:36:0)
[20:23:04.269] Timer tick, asking Buildbucket for the build status
[20:23:04.543] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:04.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:37:0) after 1m0s
[20:24:04.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:37:0)
[20:24:04.632] Timer tick, asking Buildbucket for the build status
[20:24:04.857] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:04.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:38:0) after 1m0s
[20:25:04.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:38:0)
[20:25:04.906] Timer tick, asking Buildbucket for the build status
[20:25:05.223] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:05.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:39:0) after 1m0s
[20:26:05.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:39:0)
[20:26:05.254] Timer tick, asking Buildbucket for the build status
[20:26:05.434] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:05.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:40:0) after 1m0s
[20:27:05.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:40:0)
[20:27:05.579] Timer tick, asking Buildbucket for the build status
[20:27:05.715] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:05.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:41:0) after 1m0s
[20:28:05.789] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:41:0)
[20:28:05.789] Timer tick, asking Buildbucket for the build status
[20:28:05.979] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:05.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:42:0) after 1m0s
[20:29:06.021] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:42:0)
[20:29:06.021] Timer tick, asking Buildbucket for the build status
[20:29:06.182] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:06.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:43:0) after 1m0s
[20:30:06.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:43:0)
[20:30:06.248] Timer tick, asking Buildbucket for the build status
[20:30:06.593] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:06.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:44:0) after 1m0s
[20:31:06.633] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:44:0)
[20:31:06.633] Timer tick, asking Buildbucket for the build status
[20:31:07.407] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:07.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:45:0) after 1m0s
[20:32:07.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:45:0)
[20:32:07.513] Timer tick, asking Buildbucket for the build status
[20:32:09.613] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:09.613] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:46:0) after 1m0s
[20:33:09.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:46:0)
[20:33:09.726] Timer tick, asking Buildbucket for the build status
[20:33:10.039] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:10.039] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:47:0) after 1m0s
[20:34:10.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:47:0)
[20:34:10.205] Timer tick, asking Buildbucket for the build status
[20:34:10.387] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:10.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:48:0) after 1m0s
[20:35:10.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:48:0)
[20:35:10.631] Timer tick, asking Buildbucket for the build status
[20:35:10.829] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:10.830] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:49:0) after 1m0s
[20:36:10.865] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:49:0)
[20:36:10.865] Timer tick, asking Buildbucket for the build status
[20:36:11.003] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:11.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:50:0) after 1m0s
[20:37:11.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:50:0)
[20:37:11.127] Timer tick, asking Buildbucket for the build status
[20:37:11.916] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:11.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:51:0) after 1m0s
[20:38:11.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:51:0)
[20:38:11.996] Timer tick, asking Buildbucket for the build status
[20:38:12.417] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:12.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:52:0) after 1m0s
[20:39:12.553] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:52:0)
[20:39:12.553] Timer tick, asking Buildbucket for the build status
[20:39:12.854] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:12.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:53:0) after 1m0s
[20:40:13.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:53:0)
[20:40:13.091] Timer tick, asking Buildbucket for the build status
[20:40:13.383] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:13.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:54:0) after 1m0s
[20:41:13.447] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:54:0)
[20:41:13.447] Timer tick, asking Buildbucket for the build status
[20:41:13.655] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:13.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:55:0) after 1m0s
[20:42:13.746] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:55:0)
[20:42:13.746] Timer tick, asking Buildbucket for the build status
[20:42:13.992] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:13.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:56:0) after 1m0s
[20:43:14.032] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:56:0)
[20:43:14.032] Timer tick, asking Buildbucket for the build status
[20:43:14.223] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:14.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:57:0) after 1m0s
[20:44:14.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:57:0)
[20:44:14.298] Timer tick, asking Buildbucket for the build status
[20:44:14.411] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:14.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:58:0) after 1m0s
[20:45:14.590] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:58:0)
[20:45:14.590] Timer tick, asking Buildbucket for the build status
[20:45:14.755] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:14.755] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:59:0) after 1m0s
[20:46:14.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:59:0)
[20:46:14.926] Timer tick, asking Buildbucket for the build status
[20:46:15.182] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:15.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:60:0) after 1m0s
[20:47:15.292] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:60:0)
[20:47:15.292] Timer tick, asking Buildbucket for the build status
[20:47:15.467] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:15.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:61:0) after 1m0s
[20:48:15.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:61:0)
[20:48:15.491] Timer tick, asking Buildbucket for the build status
[20:48:16.008] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:16.008] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:62:0) after 1m0s
[20:49:16.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:62:0)
[20:49:16.028] Timer tick, asking Buildbucket for the build status
[20:49:17.637] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:17.637] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:63:0) after 1m0s
[20:50:17.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:63:0)
[20:50:17.646] Timer tick, asking Buildbucket for the build status
[20:50:17.840] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:17.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:64:0) after 1m0s
[20:51:17.926] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:64:0)
[20:51:17.926] Timer tick, asking Buildbucket for the build status
[20:51:18.045] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:18.045] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:65:0) after 1m0s
[20:52:18.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:65:0)
[20:52:18.096] Timer tick, asking Buildbucket for the build status
[20:52:18.249] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:18.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:66:0) after 1m0s
[20:53:18.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:66:0)
[20:53:18.306] Timer tick, asking Buildbucket for the build status
[20:53:18.545] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:18.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:67:0) after 1m0s
[20:54:18.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:67:0)
[20:54:18.907] Timer tick, asking Buildbucket for the build status
[20:54:24.845] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:24.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:68:0) after 1m0s
[20:55:24.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:68:0)
[20:55:24.918] Timer tick, asking Buildbucket for the build status
[20:55:25.364] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:25.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:69:0) after 1m0s
[20:56:25.485] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:69:0)
[20:56:25.485] Timer tick, asking Buildbucket for the build status
[20:56:25.646] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:25.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:70:0) after 1m0s
[20:57:25.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:70:0)
[20:57:25.714] Timer tick, asking Buildbucket for the build status
[20:57:25.958] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:25.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:71:0) after 1m0s
[20:58:26.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:71:0)
[20:58:26.037] Timer tick, asking Buildbucket for the build status
[20:58:26.372] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:26.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:72:0) after 1m0s
[20:59:26.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:72:0)
[20:59:26.482] Timer tick, asking Buildbucket for the build status
[20:59:26.680] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:26.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:73:0) after 1m0s
[21:00:26.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:73:0)
[21:00:26.741] Timer tick, asking Buildbucket for the build status
[21:00:27.003] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:27.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:74:0) after 1m0s
[21:01:27.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:74:0)
[21:01:27.039] Timer tick, asking Buildbucket for the build status
[21:01:27.226] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:27.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:75:0) after 1m0s
[21:02:27.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:75:0)
[21:02:27.262] Timer tick, asking Buildbucket for the build status
[21:02:27.409] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:27.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:76:0) after 1m0s
[21:03:27.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:76:0)
[21:03:27.452] Timer tick, asking Buildbucket for the build status
[21:03:28.591] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:28.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:77:0) after 1m0s
[21:04:28.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:77:0)
[21:04:28.786] Timer tick, asking Buildbucket for the build status
[21:04:28.960] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:28.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:78:0) after 1m0s
[21:05:29.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:78:0)
[21:05:29.071] Timer tick, asking Buildbucket for the build status
[21:05:29.364] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:29.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:79:0) after 1m0s
[21:06:29.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:79:0)
[21:06:29.496] Timer tick, asking Buildbucket for the build status
[21:06:31.485] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:31.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:80:0) after 1m0s
[21:07:31.490] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:80:0)
[21:07:31.490] Timer tick, asking Buildbucket for the build status
[21:07:31.981] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:31.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:81:0) after 1m0s
[21:08:32.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:81:0)
[21:08:32.073] Timer tick, asking Buildbucket for the build status
[21:08:32.525] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:32.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:82:0) after 1m0s
[21:09:32.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:82:0)
[21:09:32.694] Timer tick, asking Buildbucket for the build status
[21:09:32.859] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:32.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:83:0) after 1m0s
[21:10:32.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:83:0)
[21:10:32.919] Timer tick, asking Buildbucket for the build status
[21:10:33.138] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:33.138] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:84:0) after 1m0s
[21:11:33.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:84:0)
[21:11:33.401] Timer tick, asking Buildbucket for the build status
[21:11:33.564] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:33.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:85:0) after 1m0s
[21:12:33.674] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:85:0)
[21:12:33.674] Timer tick, asking Buildbucket for the build status
[21:12:33.887] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:33.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:86:0) after 1m0s
[21:13:34.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:86:0)
[21:13:34.013] Timer tick, asking Buildbucket for the build status
[21:13:34.338] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:34.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:87:0) after 1m0s
[21:14:34.423] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:87:0)
[21:14:34.423] Timer tick, asking Buildbucket for the build status
[21:14:34.553] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:34.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:88:0) after 1m0s
[21:15:34.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:88:0)
[21:15:34.580] Timer tick, asking Buildbucket for the build status
[21:15:34.704] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:34.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:89:0) after 1m0s
[21:16:34.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:89:0)
[21:16:34.831] Timer tick, asking Buildbucket for the build status
[21:16:35.215] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:35.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:90:0) after 1m0s
[21:17:35.270] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:90:0)
[21:17:35.270] Timer tick, asking Buildbucket for the build status
[21:17:35.423] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:35.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:91:0) after 1m0s
[21:18:35.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:91:0)
[21:18:35.509] Timer tick, asking Buildbucket for the build status
[21:18:35.744] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:35.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:92:0) after 1m0s
[21:19:35.772] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:92:0)
[21:19:35.772] Timer tick, asking Buildbucket for the build status
[21:19:36.296] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:36.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:93:0) after 1m0s
[21:20:36.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:93:0)
[21:20:36.365] Timer tick, asking Buildbucket for the build status
[21:20:36.487] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:36.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:94:0) after 1m0s
[21:21:36.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:94:0)
[21:21:36.574] Timer tick, asking Buildbucket for the build status
[21:21:36.718] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:36.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:95:0) after 1m0s
[21:22:36.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:95:0)
[21:22:36.803] Timer tick, asking Buildbucket for the build status
[21:22:36.937] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:36.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:96:0) after 1m0s
[21:23:37.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:96:0)
[21:23:37.029] Timer tick, asking Buildbucket for the build status
[21:23:37.268] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:37.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:97:0) after 1m0s
[21:24:37.329] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:97:0)
[21:24:37.329] Timer tick, asking Buildbucket for the build status
[21:24:37.618] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:37.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:98:0) after 1m0s
[21:25:37.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:98:0)
[21:25:37.656] Timer tick, asking Buildbucket for the build status
[21:25:37.951] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:37.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:99:0) after 1m0s
[21:26:38.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:99:0)
[21:26:38.064] Timer tick, asking Buildbucket for the build status
[21:26:38.238] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:38.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:100:0) after 1m0s
[21:27:38.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:100:0)
[21:27:38.285] Timer tick, asking Buildbucket for the build status
[21:27:38.454] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:38.454] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:101:0) after 1m0s
[21:28:38.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:101:0)
[21:28:38.522] Timer tick, asking Buildbucket for the build status
[21:28:38.831] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:38.831] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:102:0) after 1m0s
[21:29:38.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:102:0)
[21:29:38.875] Timer tick, asking Buildbucket for the build status
[21:29:39.173] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:39.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:103:0) after 1m0s
[21:30:39.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:103:0)
[21:30:39.205] Timer tick, asking Buildbucket for the build status
[21:30:39.376] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:39.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:104:0) after 1m0s
[21:31:39.425] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:104:0)
[21:31:39.425] Timer tick, asking Buildbucket for the build status
[21:31:40.012] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:40.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:105:0) after 1m0s
[21:32:40.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:105:0)
[21:32:40.108] Timer tick, asking Buildbucket for the build status
[21:32:41.799] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:41.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:106:0) after 1m0s
[21:33:41.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:106:0)
[21:33:41.811] Timer tick, asking Buildbucket for the build status
[21:33:41.907] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:41.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:107:0) after 1m0s
[21:34:41.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:107:0)
[21:34:41.966] Timer tick, asking Buildbucket for the build status
[21:34:42.311] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:42.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:108:0) after 1m0s
[21:35:42.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:108:0)
[21:35:42.383] Timer tick, asking Buildbucket for the build status
[21:35:43.347] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:43.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:109:0) after 1m0s
[21:36:43.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:109:0)
[21:36:43.411] Timer tick, asking Buildbucket for the build status
[21:36:43.552] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:43.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:110:0) after 1m0s
[21:37:43.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:110:0)
[21:37:43.536] Timer tick, asking Buildbucket for the build status
[21:37:43.651] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:43.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:111:0) after 1m0s
[21:38:43.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:111:0)
[21:38:43.647] Timer tick, asking Buildbucket for the build status
[21:38:44.018] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:44.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:112:0) after 1m0s
[21:39:44.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:112:0)
[21:39:44.074] Timer tick, asking Buildbucket for the build status
[21:39:44.463] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:44.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:113:0) after 1m0s
[21:40:44.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:113:0)
[21:40:44.510] Timer tick, asking Buildbucket for the build status
[21:40:44.667] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:44.667] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:114:0) after 1m0s
[21:41:44.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:114:0)
[21:41:44.700] Timer tick, asking Buildbucket for the build status
[21:41:44.922] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:44.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:115:0) after 1m0s
[21:42:44.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:115:0)
[21:42:44.953] Timer tick, asking Buildbucket for the build status
[21:42:45.104] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:45.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:116:0) after 1m0s
[21:43:45.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:116:0)
[21:43:45.123] Timer tick, asking Buildbucket for the build status
[21:43:45.314] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:45.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:117:0) after 1m0s
[21:44:45.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:117:0)
[21:44:45.402] Timer tick, asking Buildbucket for the build status
[21:44:45.695] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:45.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:118:0) after 1m0s
[21:45:45.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:118:0)
[21:45:45.724] Timer tick, asking Buildbucket for the build status
[21:45:45.842] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:45.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:119:0) after 1m0s
[21:46:45.905] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:119:0)
[21:46:45.905] Timer tick, asking Buildbucket for the build status
[21:46:46.361] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:46.361] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:120:0) after 1m0s
[21:47:46.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:120:0)
[21:47:46.373] Timer tick, asking Buildbucket for the build status
[21:47:46.538] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:46.538] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:121:0) after 1m0s
[21:48:46.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:121:0)
[21:48:46.629] Timer tick, asking Buildbucket for the build status
[21:48:47.275] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:47.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:122:0) after 1m0s
[21:49:47.361] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:122:0)
[21:49:47.361] Timer tick, asking Buildbucket for the build status
[21:49:47.641] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:47.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:123:0) after 1m0s
[21:50:47.627] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:123:0)
[21:50:47.627] Timer tick, asking Buildbucket for the build status
[21:50:47.920] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:47.920] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:124:0) after 1m0s
[21:51:47.946] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:124:0)
[21:51:47.946] Timer tick, asking Buildbucket for the build status
[21:51:48.140] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:48.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:125:0) after 1m0s
[21:52:48.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:125:0)
[21:52:48.229] Timer tick, asking Buildbucket for the build status
[21:52:48.862] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:48.862] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:126:0) after 1m0s
[21:53:48.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:126:0)
[21:53:48.880] Timer tick, asking Buildbucket for the build status
[21:53:49.209] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:49.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:127:0) after 1m0s
[21:54:49.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:127:0)
[21:54:49.235] Timer tick, asking Buildbucket for the build status
[21:54:49.413] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:49.413] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:128:0) after 1m0s
[21:55:49.440] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:128:0)
[21:55:49.440] Timer tick, asking Buildbucket for the build status
[21:55:49.608] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:49.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:129:0) after 1m0s
[21:56:49.655] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:129:0)
[21:56:49.655] Timer tick, asking Buildbucket for the build status
[21:56:50.164] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:50.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:130:0) after 1m0s
[21:57:50.183] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:130:0)
[21:57:50.183] Timer tick, asking Buildbucket for the build status
[21:57:50.307] Build 8875223701084773552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:50.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040653763088884560:131:0) after 1m0s
[21:58:15.541] Received PubSub notification, asking Buildbucket for the build status
[21:58:15.867] Build 8875223701084773552: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:58:15.867] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1594331894401456",
"created_by": "project:chromium",
"created_ts": "1594324126123342",
"id": "8875223701084773552",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d831f0788ac200b96f02e08229110de5f9939e9\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-98-by8l\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 28494, \"got_angle_revision\": \"58afe4cb7a7b4ad4a89de35e033618aefdf34a5e\", \"got_dawn_revision\": \"dab10eae8a8257b24d7475eaf473b0158b01ea24\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"1d831f0788ac200b96f02e08229110de5f9939e9\", \"got_revision_cp\": \"refs/heads/master@{#786871}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"08a294d37693b7990f73bce24bc2bbc7bba32c4a\", \"got_v8_revision\": \"e078f1d43a5ef91a701f1686917b6fac5176be85\", \"got_v8_revision_cp\": \"refs/heads/8.6.82@{#1}\", \"got_webrtc_revision\": \"60ed45996279a352133299647dff1b4cdd77925b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31689}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d831f0788ac200b96f02e08229110de5f9939e9\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-98-by8l\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5378-e275056\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1594324130862534",
"status": "COMPLETED",
"status_changed_ts": "1594331895078227",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28494",
"builder:Deterministic Linux",
"buildset:commit/git/1d831f0788ac200b96f02e08229110de5f9939e9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d831f0788ac200b96f02e08229110de5f9939e9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040653763088884560",
"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/8875223701084773552/+/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:4d4df116a0344710",
"user_agent:luci-scheduler"
],
"updated_ts": "1594331895124808",
"url": "https://ci.chromium.org/b/8875223701084773552",
"utcnow_ts": "1594331895845089"
}
}
[21:58:15.867] Invocation finished in 2h9m31.038479518s with status SUCCEEDED