[01:30:36.689] New invocation is queued and will start shortly
[01:30:38.044] Starting the invocation (attempt 1)
[01:30:38.098] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:30:38.099] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:30:38.099] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9048242400037624496",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b1650119aa8cbed2b37f5c1d2655a42f72408d39\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9048242400037624496",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/b1650119aa8cbed2b37f5c1d2655a42f72408d39",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1650119aa8cbed2b37f5c1d2655a42f72408d39",
"gitiles_ref:refs/heads/master"
]
}
[01:30:48.018] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1587087039403845",
"id": "8882812336529124912",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1650119aa8cbed2b37f5c1d2655a42f72408d39\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1587087046431104",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27571",
"builder:Deterministic Linux",
"buildset:commit/git/b1650119aa8cbed2b37f5c1d2655a42f72408d39",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1650119aa8cbed2b37f5c1d2655a42f72408d39",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9048242400037624496",
"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/8882812336529124912/+/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": "1587087046431316",
"url": "https://ci.chromium.org/b/8882812336529124912",
"utcnow_ts": "1587087047953901"
}
}
[01:30:48.018] Task URL: https://ci.chromium.org/b/8882812336529124912
[01:30:48.018] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:2:0) after 1m0s
[01:30:52.729] Received PubSub notification, asking Buildbucket for the build status
[01:30:53.401] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:47.998] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:2:0)
[01:31:47.998] Timer tick, asking Buildbucket for the build status
[01:31:48.217] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:48.217] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:4:0) after 1m0s
[01:32:48.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:4:0)
[01:32:48.260] Timer tick, asking Buildbucket for the build status
[01:32:48.845] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:48.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:5:0) after 1m0s
[01:33:48.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:5:0)
[01:33:48.896] Timer tick, asking Buildbucket for the build status
[01:33:49.044] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:49.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:6:0) after 1m0s
[01:34:49.119] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:6:0)
[01:34:49.119] Timer tick, asking Buildbucket for the build status
[01:34:49.499] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:49.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:7:0) after 1m0s
[01:35:49.568] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:7:0)
[01:35:49.568] Timer tick, asking Buildbucket for the build status
[01:35:51.043] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:51.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:8:0) after 1m0s
[01:36:51.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:8:0)
[01:36:51.075] Timer tick, asking Buildbucket for the build status
[01:36:51.236] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:51.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:9:0) after 1m0s
[01:37:51.366] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:9:0)
[01:37:51.366] Timer tick, asking Buildbucket for the build status
[01:37:51.525] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:51.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:10:0) after 1m0s
[01:38:51.587] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:10:0)
[01:38:51.587] Timer tick, asking Buildbucket for the build status
[01:38:51.742] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:51.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:11:0) after 1m0s
[01:39:51.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:11:0)
[01:39:51.790] Timer tick, asking Buildbucket for the build status
[01:39:51.956] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:51.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:12:0) after 1m0s
[01:40:52.004] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:12:0)
[01:40:52.004] Timer tick, asking Buildbucket for the build status
[01:40:52.310] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:52.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:13:0) after 1m0s
[01:41:52.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:13:0)
[01:41:52.371] Timer tick, asking Buildbucket for the build status
[01:41:52.734] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:52.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:14:0) after 1m0s
[01:42:52.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:14:0)
[01:42:52.831] Timer tick, asking Buildbucket for the build status
[01:42:53.086] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:53.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:15:0) after 1m0s
[01:43:53.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:15:0)
[01:43:53.161] Timer tick, asking Buildbucket for the build status
[01:43:53.476] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:53.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:16:0) after 1m0s
[01:44:53.523] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:16:0)
[01:44:53.523] Timer tick, asking Buildbucket for the build status
[01:44:54.485] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:54.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:17:0) after 1m0s
[01:45:54.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:17:0)
[01:45:54.515] Timer tick, asking Buildbucket for the build status
[01:45:56.715] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:56.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:18:0) after 1m0s
[01:46:56.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:18:0)
[01:46:56.765] Timer tick, asking Buildbucket for the build status
[01:46:57.235] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:57.235] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:19:0) after 1m0s
[01:47:57.241] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:19:0)
[01:47:57.241] Timer tick, asking Buildbucket for the build status
[01:47:57.423] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:57.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:20:0) after 1m0s
[01:48:57.438] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:20:0)
[01:48:57.438] Timer tick, asking Buildbucket for the build status
[01:48:59.149] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:59.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:21:0) after 1m0s
[01:49:59.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:21:0)
[01:49:59.235] Timer tick, asking Buildbucket for the build status
[01:49:59.372] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:59.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:22:0) after 1m0s
[01:50:59.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:22:0)
[01:50:59.527] Timer tick, asking Buildbucket for the build status
[01:50:59.820] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:59.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:23:0) after 1m0s
[01:51:59.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:23:0)
[01:51:59.852] Timer tick, asking Buildbucket for the build status
[01:52:00.200] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:00.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:24:0) after 1m0s
[01:53:00.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:24:0)
[01:53:00.372] Timer tick, asking Buildbucket for the build status
[01:53:00.558] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:00.558] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:25:0) after 1m0s
[01:54:00.605] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:25:0)
[01:54:00.605] Timer tick, asking Buildbucket for the build status
[01:54:00.759] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:00.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:26:0) after 1m0s
[01:55:00.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:26:0)
[01:55:00.848] Timer tick, asking Buildbucket for the build status
[01:55:01.028] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:01.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:27:0) after 1m0s
[01:56:01.174] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:27:0)
[01:56:01.174] Timer tick, asking Buildbucket for the build status
[01:56:01.308] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:01.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:28:0) after 1m0s
[01:57:01.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:28:0)
[01:57:01.555] Timer tick, asking Buildbucket for the build status
[01:57:01.847] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:01.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:29:0) after 1m0s
[01:58:01.877] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:29:0)
[01:58:01.877] Timer tick, asking Buildbucket for the build status
[01:58:01.945] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:01.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:30:0) after 1m0s
[01:59:02.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:30:0)
[01:59:02.008] Timer tick, asking Buildbucket for the build status
[01:59:02.130] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:02.130] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:31:0) after 1m0s
[02:00:02.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:31:0)
[02:00:02.205] Timer tick, asking Buildbucket for the build status
[02:00:02.552] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:02.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:32:0) after 1m0s
[02:01:02.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:32:0)
[02:01:02.577] Timer tick, asking Buildbucket for the build status
[02:01:02.868] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:02.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:33:0) after 1m0s
[02:02:02.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:33:0)
[02:02:02.975] Timer tick, asking Buildbucket for the build status
[02:02:03.139] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:03.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:34:0) after 1m0s
[02:03:03.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:34:0)
[02:03:03.281] Timer tick, asking Buildbucket for the build status
[02:03:04.370] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:04.370] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:35:0) after 1m0s
[02:04:04.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:35:0)
[02:04:04.557] Timer tick, asking Buildbucket for the build status
[02:04:04.707] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:04.707] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:36:0) after 1m0s
[02:05:04.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:36:0)
[02:05:04.856] Timer tick, asking Buildbucket for the build status
[02:05:05.518] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:05.519] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:37:0) after 1m0s
[02:06:05.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:37:0)
[02:06:05.579] Timer tick, asking Buildbucket for the build status
[02:06:05.816] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:05.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:38:0) after 1m0s
[02:07:05.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:38:0)
[02:07:05.837] Timer tick, asking Buildbucket for the build status
[02:07:06.038] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:06.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:39:0) after 1m0s
[02:08:06.095] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:39:0)
[02:08:06.095] Timer tick, asking Buildbucket for the build status
[02:08:06.219] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:06.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:40:0) after 1m0s
[02:09:06.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:40:0)
[02:09:06.314] Timer tick, asking Buildbucket for the build status
[02:09:06.688] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:06.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:41:0) after 1m0s
[02:10:06.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:41:0)
[02:10:06.706] Timer tick, asking Buildbucket for the build status
[02:10:06.812] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:06.812] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:42:0) after 1m0s
[02:11:06.889] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:42:0)
[02:11:06.889] Timer tick, asking Buildbucket for the build status
[02:11:07.043] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:07.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:43:0) after 1m0s
[02:12:07.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:43:0)
[02:12:07.056] Timer tick, asking Buildbucket for the build status
[02:12:07.348] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:07.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:44:0) after 1m0s
[02:13:07.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:44:0)
[02:13:07.408] Timer tick, asking Buildbucket for the build status
[02:13:07.594] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:07.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:45:0) after 1m0s
[02:14:07.605] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:45:0)
[02:14:07.605] Timer tick, asking Buildbucket for the build status
[02:14:08.143] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:08.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:46:0) after 1m0s
[02:15:08.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:46:0)
[02:15:08.181] Timer tick, asking Buildbucket for the build status
[02:15:08.438] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:08.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:47:0) after 1m0s
[02:16:08.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:47:0)
[02:16:08.497] Timer tick, asking Buildbucket for the build status
[02:16:08.689] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:08.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:48:0) after 1m0s
[02:17:08.746] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:48:0)
[02:17:08.746] Timer tick, asking Buildbucket for the build status
[02:17:09.002] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:09.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:49:0) after 1m0s
[02:18:09.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:49:0)
[02:18:09.059] Timer tick, asking Buildbucket for the build status
[02:18:09.746] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:09.746] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:50:0) after 1m0s
[02:19:09.768] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:50:0)
[02:19:09.768] Timer tick, asking Buildbucket for the build status
[02:19:09.863] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:09.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:51:0) after 1m0s
[02:20:09.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:51:0)
[02:20:09.924] Timer tick, asking Buildbucket for the build status
[02:20:10.089] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:10.089] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:52:0) after 1m0s
[02:21:10.223] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:52:0)
[02:21:10.223] Timer tick, asking Buildbucket for the build status
[02:21:10.536] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:10.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:53:0) after 1m0s
[02:22:10.672] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:53:0)
[02:22:10.672] Timer tick, asking Buildbucket for the build status
[02:22:10.853] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:10.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:54:0) after 1m0s
[02:23:10.881] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:54:0)
[02:23:10.881] Timer tick, asking Buildbucket for the build status
[02:23:11.019] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:11.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:55:0) after 1m0s
[02:24:11.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:55:0)
[02:24:11.278] Timer tick, asking Buildbucket for the build status
[02:24:11.525] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:11.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:56:0) after 1m0s
[02:25:11.553] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:56:0)
[02:25:11.553] Timer tick, asking Buildbucket for the build status
[02:25:12.086] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:12.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:57:0) after 1m0s
[02:26:12.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:57:0)
[02:26:12.144] Timer tick, asking Buildbucket for the build status
[02:26:12.516] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:12.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:58:0) after 1m0s
[02:27:12.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:58:0)
[02:27:12.547] Timer tick, asking Buildbucket for the build status
[02:27:12.733] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:12.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:59:0) after 1m0s
[02:28:12.763] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:59:0)
[02:28:12.763] Timer tick, asking Buildbucket for the build status
[02:28:12.967] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:12.967] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:60:0) after 1m0s
[02:29:12.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:60:0)
[02:29:12.992] Timer tick, asking Buildbucket for the build status
[02:29:13.164] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:13.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:61:0) after 1m0s
[02:30:13.190] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:61:0)
[02:30:13.190] Timer tick, asking Buildbucket for the build status
[02:30:13.382] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:13.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:62:0) after 1m0s
[02:31:13.415] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:62:0)
[02:31:13.415] Timer tick, asking Buildbucket for the build status
[02:31:13.612] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:13.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:63:0) after 1m0s
[02:32:13.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:63:0)
[02:32:13.634] Timer tick, asking Buildbucket for the build status
[02:32:13.724] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:13.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:64:0) after 1m0s
[02:33:13.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:64:0)
[02:33:13.757] Timer tick, asking Buildbucket for the build status
[02:33:13.890] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:13.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:65:0) after 1m0s
[02:34:13.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:65:0)
[02:34:13.913] Timer tick, asking Buildbucket for the build status
[02:34:14.041] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:14.041] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:66:0) after 1m0s
[02:35:14.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:66:0)
[02:35:14.078] Timer tick, asking Buildbucket for the build status
[02:35:15.411] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:15.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:67:0) after 1m0s
[02:36:15.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:67:0)
[02:36:15.432] Timer tick, asking Buildbucket for the build status
[02:36:15.698] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:15.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:68:0) after 1m0s
[02:37:15.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:68:0)
[02:37:15.801] Timer tick, asking Buildbucket for the build status
[02:37:15.957] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:15.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:69:0) after 1m0s
[02:38:16.110] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:69:0)
[02:38:16.110] Timer tick, asking Buildbucket for the build status
[02:38:16.338] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:16.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:70:0) after 1m0s
[02:39:16.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:70:0)
[02:39:16.399] Timer tick, asking Buildbucket for the build status
[02:39:16.518] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:16.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:71:0) after 1m0s
[02:40:16.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:71:0)
[02:40:16.492] Timer tick, asking Buildbucket for the build status
[02:40:16.620] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:16.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:72:0) after 1m0s
[02:41:16.998] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:72:0)
[02:41:16.998] Timer tick, asking Buildbucket for the build status
[02:41:17.137] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:17.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:73:0) after 1m0s
[02:42:17.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:73:0)
[02:42:17.304] Timer tick, asking Buildbucket for the build status
[02:42:18.677] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:18.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:74:0) after 1m0s
[02:43:18.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:74:0)
[02:43:18.959] Timer tick, asking Buildbucket for the build status
[02:43:19.219] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:19.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:75:0) after 1m0s
[02:44:19.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:75:0)
[02:44:19.350] Timer tick, asking Buildbucket for the build status
[02:44:19.652] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:19.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:76:0) after 1m0s
[02:45:19.691] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:76:0)
[02:45:19.691] Timer tick, asking Buildbucket for the build status
[02:45:19.898] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:19.898] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:77:0) after 1m0s
[02:46:19.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:77:0)
[02:46:19.917] Timer tick, asking Buildbucket for the build status
[02:46:20.140] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:20.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:78:0) after 1m0s
[02:47:20.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:78:0)
[02:47:20.254] Timer tick, asking Buildbucket for the build status
[02:47:20.513] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:20.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:79:0) after 1m0s
[02:48:20.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:79:0)
[02:48:20.583] Timer tick, asking Buildbucket for the build status
[02:48:20.800] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:20.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:80:0) after 1m0s
[02:49:20.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:80:0)
[02:49:20.832] Timer tick, asking Buildbucket for the build status
[02:49:21.036] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:21.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:81:0) after 1m0s
[02:50:21.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:81:0)
[02:50:21.135] Timer tick, asking Buildbucket for the build status
[02:50:21.305] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:21.305] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:82:0) after 1m0s
[02:51:21.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:82:0)
[02:51:21.405] Timer tick, asking Buildbucket for the build status
[02:51:21.540] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:21.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:83:0) after 1m0s
[02:52:21.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:83:0)
[02:52:21.586] Timer tick, asking Buildbucket for the build status
[02:52:21.782] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:21.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:84:0) after 1m0s
[02:53:21.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:84:0)
[02:53:21.811] Timer tick, asking Buildbucket for the build status
[02:53:23.200] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:23.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:85:0) after 1m0s
[02:54:23.226] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:85:0)
[02:54:23.226] Timer tick, asking Buildbucket for the build status
[02:54:23.372] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:23.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:86:0) after 1m0s
[02:55:23.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:86:0)
[02:55:23.416] Timer tick, asking Buildbucket for the build status
[02:55:23.589] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:23.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:87:0) after 1m0s
[02:56:23.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:87:0)
[02:56:23.572] Timer tick, asking Buildbucket for the build status
[02:56:23.766] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:23.766] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:88:0) after 1m0s
[02:57:23.789] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:88:0)
[02:57:23.789] Timer tick, asking Buildbucket for the build status
[02:57:23.983] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:23.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:89:0) after 1m0s
[02:58:24.068] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:89:0)
[02:58:24.068] Timer tick, asking Buildbucket for the build status
[02:58:24.426] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:24.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:90:0) after 1m0s
[02:59:24.633] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:90:0)
[02:59:24.633] Timer tick, asking Buildbucket for the build status
[02:59:24.867] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:24.867] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:91:0) after 1m0s
[03:00:24.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:91:0)
[03:00:24.971] Timer tick, asking Buildbucket for the build status
[03:00:25.272] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:25.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:92:0) after 1m0s
[03:01:25.362] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:92:0)
[03:01:25.362] Timer tick, asking Buildbucket for the build status
[03:01:25.569] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:25.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:93:0) after 1m0s
[03:02:25.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:93:0)
[03:02:25.664] Timer tick, asking Buildbucket for the build status
[03:02:26.154] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:26.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:94:0) after 1m0s
[03:03:26.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:94:0)
[03:03:26.135] Timer tick, asking Buildbucket for the build status
[03:03:28.921] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:28.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:95:0) after 1m0s
[03:04:29.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:95:0)
[03:04:29.052] Timer tick, asking Buildbucket for the build status
[03:04:29.208] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:29.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:96:0) after 1m0s
[03:05:29.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:96:0)
[03:05:29.265] Timer tick, asking Buildbucket for the build status
[03:05:29.479] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:29.479] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:97:0) after 1m0s
[03:06:29.727] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:97:0)
[03:06:29.727] Timer tick, asking Buildbucket for the build status
[03:06:30.258] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:30.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:98:0) after 1m0s
[03:07:30.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:98:0)
[03:07:30.283] Timer tick, asking Buildbucket for the build status
[03:07:30.461] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:30.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:99:0) after 1m0s
[03:08:30.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:99:0)
[03:08:30.707] Timer tick, asking Buildbucket for the build status
[03:08:31.158] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:31.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:100:0) after 1m0s
[03:09:31.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:100:0)
[03:09:31.275] Timer tick, asking Buildbucket for the build status
[03:09:31.417] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:31.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:101:0) after 1m0s
[03:10:31.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:101:0)
[03:10:31.666] Timer tick, asking Buildbucket for the build status
[03:10:31.759] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:31.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:102:0) after 1m0s
[03:11:31.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:102:0)
[03:11:31.918] Timer tick, asking Buildbucket for the build status
[03:11:32.103] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:32.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:103:0) after 1m0s
[03:12:32.141] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:103:0)
[03:12:32.141] Timer tick, asking Buildbucket for the build status
[03:12:32.243] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:32.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:104:0) after 1m0s
[03:13:32.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:104:0)
[03:13:32.282] Timer tick, asking Buildbucket for the build status
[03:13:32.573] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:32.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:105:0) after 1m0s
[03:14:32.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:105:0)
[03:14:32.595] Timer tick, asking Buildbucket for the build status
[03:14:32.749] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:32.749] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:106:0) after 1m0s
[03:15:32.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:106:0)
[03:15:32.790] Timer tick, asking Buildbucket for the build status
[03:15:32.904] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:32.904] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:107:0) after 1m0s
[03:16:33.035] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:107:0)
[03:16:33.035] Timer tick, asking Buildbucket for the build status
[03:16:33.143] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:33.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:108:0) after 1m0s
[03:17:33.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:108:0)
[03:17:33.264] Timer tick, asking Buildbucket for the build status
[03:17:33.403] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:33.403] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:109:0) after 1m0s
[03:18:33.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:109:0)
[03:18:33.606] Timer tick, asking Buildbucket for the build status
[03:18:33.753] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:33.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:110:0) after 1m0s
[03:19:33.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:110:0)
[03:19:33.781] Timer tick, asking Buildbucket for the build status
[03:19:33.891] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:33.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:111:0) after 1m0s
[03:20:33.927] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:111:0)
[03:20:33.927] Timer tick, asking Buildbucket for the build status
[03:20:35.512] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:35.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:112:0) after 1m0s
[03:21:35.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:112:0)
[03:21:35.542] Timer tick, asking Buildbucket for the build status
[03:21:35.756] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:35.756] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:113:0) after 1m0s
[03:22:35.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:113:0)
[03:22:35.799] Timer tick, asking Buildbucket for the build status
[03:22:35.987] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:35.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:114:0) after 1m0s
[03:23:36.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:114:0)
[03:23:36.112] Timer tick, asking Buildbucket for the build status
[03:23:36.439] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:36.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:115:0) after 1m0s
[03:24:36.529] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:115:0)
[03:24:36.529] Timer tick, asking Buildbucket for the build status
[03:24:36.952] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:36.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:116:0) after 1m0s
[03:25:36.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:116:0)
[03:25:36.944] Timer tick, asking Buildbucket for the build status
[03:25:37.112] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:37.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:117:0) after 1m0s
[03:26:37.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:117:0)
[03:26:37.101] Timer tick, asking Buildbucket for the build status
[03:26:37.241] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:37.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:118:0) after 1m0s
[03:27:37.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:118:0)
[03:27:37.280] Timer tick, asking Buildbucket for the build status
[03:27:37.535] Build 8882812336529124912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:37.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9048242400037624496:119:0) after 1m0s
[03:27:48.005] Received PubSub notification, asking Buildbucket for the build status
[03:27:48.098] Build 8882812336529124912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:27:48.098] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1587094067505264",
"created_by": "project:chromium",
"created_ts": "1587087039403845",
"id": "8882812336529124912",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1650119aa8cbed2b37f5c1d2655a42f72408d39\"}}",
"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-central1-b-8-40-jggx\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27571, \"got_angle_revision\": \"f93cc8bda48da7379338c40ddcd7639725cd464c\", \"got_dawn_revision\": \"0ff7ed41ecc5ad70b0c16844fdfced62b0b324b8\", \"got_nacl_revision\": \"d304d90ecc17351ce0fdab3e7452052a469c0976\", \"got_revision\": \"b1650119aa8cbed2b37f5c1d2655a42f72408d39\", \"got_revision_cp\": \"refs/heads/master@{#759895}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"5470988c40331b8a43a9c4d780fc1b6565a3f62d\", \"got_v8_revision\": \"a3564739e7f55af8872a5050f1fa69bbfde7650f\", \"got_v8_revision_cp\": \"refs/heads/8.4.107@{#1}\", \"got_webrtc_revision\": \"4479a822c03f957dc0dee78931ead43364863947\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31092}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1650119aa8cbed2b37f5c1d2655a42f72408d39\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-40-jggx\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4985-2a273fe\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1587087051927512",
"status": "COMPLETED",
"status_changed_ts": "1587094067791434",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27571",
"builder:Deterministic Linux",
"buildset:commit/git/b1650119aa8cbed2b37f5c1d2655a42f72408d39",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1650119aa8cbed2b37f5c1d2655a42f72408d39",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9048242400037624496",
"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/8882812336529124912/+/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:4b9e940e346ea210",
"user_agent:luci-scheduler"
],
"updated_ts": "1587094067795888",
"url": "https://ci.chromium.org/b/8882812336529124912",
"utcnow_ts": "1587094068085342"
}
}
[03:27:48.098] Invocation finished in 1h57m11.424168954s with status SUCCEEDED