[08:22:22.044] New invocation is queued and will start shortly
[08:22:23.124] Starting the invocation (attempt 1)
[08:22:23.171] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:22:23.171] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:22:23.171] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9040696946385526464",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b10e72a75c34b8a17754144690cd5dce8534437d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9040696946385526464",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/b10e72a75c34b8a17754144690cd5dce8534437d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b10e72a75c34b8a17754144690cd5dce8534437d",
"gitiles_ref:refs/heads/master"
]
}
[08:22:24.215] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1594282943292561",
"id": "8875266884412493920",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b10e72a75c34b8a17754144690cd5dce8534437d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594282943963224",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28489",
"builder:Deterministic Linux",
"buildset:commit/git/b10e72a75c34b8a17754144690cd5dce8534437d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b10e72a75c34b8a17754144690cd5dce8534437d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040696946385526464",
"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/8875266884412493920/+/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": "1594282943963994",
"url": "https://ci.chromium.org/b/8875266884412493920",
"utcnow_ts": "1594282944197608"
}
}
[08:22:24.215] Task URL: https://ci.chromium.org/b/8875266884412493920
[08:22:24.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:2:0) after 1m0s
[08:22:59.404] Received PubSub notification, asking Buildbucket for the build status
[08:22:59.509] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:24.380] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:2:0)
[08:23:24.381] Timer tick, asking Buildbucket for the build status
[08:23:28.854] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:28.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:4:0) after 1m0s
[08:24:28.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:4:0)
[08:24:28.944] Timer tick, asking Buildbucket for the build status
[08:24:29.081] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:29.081] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:5:0) after 1m0s
[08:25:29.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:5:0)
[08:25:29.321] Timer tick, asking Buildbucket for the build status
[08:25:29.461] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:29.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:6:0) after 1m0s
[08:26:29.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:6:0)
[08:26:29.544] Timer tick, asking Buildbucket for the build status
[08:26:29.677] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:29.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:7:0) after 1m0s
[08:27:29.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:7:0)
[08:27:29.895] Timer tick, asking Buildbucket for the build status
[08:27:30.092] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:30.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:8:0) after 1m0s
[08:28:30.253] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:8:0)
[08:28:30.253] Timer tick, asking Buildbucket for the build status
[08:28:30.455] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:30.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:9:0) after 1m0s
[08:29:30.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:9:0)
[08:29:30.611] Timer tick, asking Buildbucket for the build status
[08:29:30.847] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:30.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:10:0) after 1m0s
[08:30:30.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:10:0)
[08:30:30.995] Timer tick, asking Buildbucket for the build status
[08:30:33.815] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:33.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:11:0) after 1m0s
[08:31:34.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:11:0)
[08:31:34.454] Timer tick, asking Buildbucket for the build status
[08:31:34.592] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:34.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:12:0) after 1m0s
[08:32:34.654] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:12:0)
[08:32:34.654] Timer tick, asking Buildbucket for the build status
[08:32:34.868] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:34.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:13:0) after 1m0s
[08:33:35.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:13:0)
[08:33:35.031] Timer tick, asking Buildbucket for the build status
[08:33:35.605] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:35.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:14:0) after 1m0s
[08:34:35.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:14:0)
[08:34:35.700] Timer tick, asking Buildbucket for the build status
[08:34:35.884] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:35.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:15:0) after 1m0s
[08:35:35.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:15:0)
[08:35:35.994] Timer tick, asking Buildbucket for the build status
[08:35:36.740] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:36.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:16:0) after 1m0s
[08:36:36.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:16:0)
[08:36:36.765] Timer tick, asking Buildbucket for the build status
[08:36:37.096] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:37.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:17:0) after 1m0s
[08:37:37.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:17:0)
[08:37:37.128] Timer tick, asking Buildbucket for the build status
[08:37:37.294] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:37.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:18:0) after 1m0s
[08:38:37.316] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:18:0)
[08:38:37.316] Timer tick, asking Buildbucket for the build status
[08:38:37.641] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:37.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:19:0) after 1m0s
[08:39:37.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:19:0)
[08:39:37.730] Timer tick, asking Buildbucket for the build status
[08:39:37.944] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:37.944] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:20:0) after 1m0s
[08:40:38.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:20:0)
[08:40:38.024] Timer tick, asking Buildbucket for the build status
[08:40:38.211] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:38.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:21:0) after 1m0s
[08:41:38.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:21:0)
[08:41:38.236] Timer tick, asking Buildbucket for the build status
[08:41:38.481] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:38.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:22:0) after 1m0s
[08:42:38.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:22:0)
[08:42:38.522] Timer tick, asking Buildbucket for the build status
[08:42:38.775] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:38.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:23:0) after 1m0s
[08:43:38.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:23:0)
[08:43:38.835] Timer tick, asking Buildbucket for the build status
[08:43:38.979] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:38.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:24:0) after 1m0s
[08:44:38.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:24:0)
[08:44:38.994] Timer tick, asking Buildbucket for the build status
[08:44:39.102] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:39.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:25:0) after 1m0s
[08:45:39.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:25:0)
[08:45:39.134] Timer tick, asking Buildbucket for the build status
[08:45:39.258] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:39.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:26:0) after 1m0s
[08:46:39.417] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:26:0)
[08:46:39.417] Timer tick, asking Buildbucket for the build status
[08:46:39.730] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:39.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:27:0) after 1m0s
[08:47:39.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:27:0)
[08:47:39.861] Timer tick, asking Buildbucket for the build status
[08:47:48.215] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:48.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:28:0) after 1m0s
[08:48:48.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:28:0)
[08:48:48.416] Timer tick, asking Buildbucket for the build status
[08:48:48.525] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:48.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:29:0) after 1m0s
[08:49:48.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:29:0)
[08:49:48.608] Timer tick, asking Buildbucket for the build status
[08:49:48.782] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:48.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:30:0) after 1m0s
[08:50:48.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:30:0)
[08:50:48.893] Timer tick, asking Buildbucket for the build status
[08:50:49.163] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:49.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:31:0) after 1m0s
[08:51:49.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:31:0)
[08:51:49.294] Timer tick, asking Buildbucket for the build status
[08:51:49.452] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:49.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:32:0) after 1m0s
[08:52:49.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:32:0)
[08:52:49.650] Timer tick, asking Buildbucket for the build status
[08:52:49.807] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:49.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:33:0) after 1m0s
[08:53:49.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:33:0)
[08:53:49.866] Timer tick, asking Buildbucket for the build status
[08:53:52.492] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:52.492] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:34:0) after 1m0s
[08:54:52.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:34:0)
[08:54:52.534] Timer tick, asking Buildbucket for the build status
[08:54:52.709] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:52.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:35:0) after 1m0s
[08:55:52.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:35:0)
[08:55:52.738] Timer tick, asking Buildbucket for the build status
[08:55:52.927] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:52.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:36:0) after 1m0s
[08:56:54.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:36:0)
[08:56:54.105] Timer tick, asking Buildbucket for the build status
[08:56:54.374] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:54.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:37:0) after 1m0s
[08:57:54.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:37:0)
[08:57:54.536] Timer tick, asking Buildbucket for the build status
[08:57:54.676] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:54.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:38:0) after 1m0s
[08:58:54.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:38:0)
[08:58:54.954] Timer tick, asking Buildbucket for the build status
[08:58:55.070] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:55.070] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:39:0) after 1m0s
[08:59:55.614] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:39:0)
[08:59:55.614] Timer tick, asking Buildbucket for the build status
[08:59:55.754] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:55.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:40:0) after 1m0s
[09:00:57.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:40:0)
[09:00:57.188] Timer tick, asking Buildbucket for the build status
[09:00:57.328] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:57.328] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:41:0) after 1m0s
[09:01:57.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:41:0)
[09:01:57.822] Timer tick, asking Buildbucket for the build status
[09:01:57.940] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:57.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:42:0) after 1m0s
[09:02:58.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:42:0)
[09:02:58.005] Timer tick, asking Buildbucket for the build status
[09:02:58.115] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:58.115] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:43:0) after 1m0s
[09:03:58.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:43:0)
[09:03:58.254] Timer tick, asking Buildbucket for the build status
[09:03:58.646] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:58.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:44:0) after 1m0s
[09:04:58.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:44:0)
[09:04:58.751] Timer tick, asking Buildbucket for the build status
[09:04:58.861] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:58.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:45:0) after 1m0s
[09:05:59.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:45:0)
[09:05:59.224] Timer tick, asking Buildbucket for the build status
[09:05:59.362] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:59.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:46:0) after 1m0s
[09:06:59.599] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:46:0)
[09:06:59.599] Timer tick, asking Buildbucket for the build status
[09:06:59.770] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:59.770] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:47:0) after 1m0s
[09:08:00.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:47:0)
[09:08:00.096] Timer tick, asking Buildbucket for the build status
[09:08:00.417] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:00.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:48:0) after 1m0s
[09:09:00.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:48:0)
[09:09:00.629] Timer tick, asking Buildbucket for the build status
[09:09:00.917] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:00.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:49:0) after 1m0s
[09:10:01.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:49:0)
[09:10:01.105] Timer tick, asking Buildbucket for the build status
[09:10:02.017] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:02.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:50:0) after 1m0s
[09:11:02.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:50:0)
[09:11:02.056] Timer tick, asking Buildbucket for the build status
[09:11:02.294] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:02.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:51:0) after 1m0s
[09:12:02.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:51:0)
[09:12:02.589] Timer tick, asking Buildbucket for the build status
[09:12:02.760] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:02.760] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:52:0) after 1m0s
[09:13:03.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:52:0)
[09:13:03.395] Timer tick, asking Buildbucket for the build status
[09:13:03.577] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:03.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:53:0) after 1m0s
[09:14:03.840] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:53:0)
[09:14:03.840] Timer tick, asking Buildbucket for the build status
[09:14:04.194] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:04.194] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:54:0) after 1m0s
[09:15:04.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:54:0)
[09:15:04.306] Timer tick, asking Buildbucket for the build status
[09:15:04.746] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:04.746] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:55:0) after 1m0s
[09:16:04.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:55:0)
[09:16:04.809] Timer tick, asking Buildbucket for the build status
[09:16:04.981] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:04.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:56:0) after 1m0s
[09:17:05.032] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:56:0)
[09:17:05.032] Timer tick, asking Buildbucket for the build status
[09:17:05.233] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:05.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:57:0) after 1m0s
[09:18:05.309] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:57:0)
[09:18:05.309] Timer tick, asking Buildbucket for the build status
[09:18:05.481] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:05.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:58:0) after 1m0s
[09:19:05.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:58:0)
[09:19:05.513] Timer tick, asking Buildbucket for the build status
[09:19:07.655] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:07.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:59:0) after 1m0s
[09:20:07.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:59:0)
[09:20:07.831] Timer tick, asking Buildbucket for the build status
[09:20:08.204] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:08.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:60:0) after 1m0s
[09:21:08.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:60:0)
[09:21:08.233] Timer tick, asking Buildbucket for the build status
[09:21:08.423] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:08.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:61:0) after 1m0s
[09:22:08.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:61:0)
[09:22:08.468] Timer tick, asking Buildbucket for the build status
[09:22:08.958] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:08.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:62:0) after 1m0s
[09:23:09.038] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:62:0)
[09:23:09.038] Timer tick, asking Buildbucket for the build status
[09:23:09.183] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:09.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:63:0) after 1m0s
[09:24:09.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:63:0)
[09:24:09.303] Timer tick, asking Buildbucket for the build status
[09:24:09.514] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:09.514] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:64:0) after 1m0s
[09:25:09.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:64:0)
[09:25:09.657] Timer tick, asking Buildbucket for the build status
[09:25:09.833] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:09.833] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:65:0) after 1m0s
[09:26:10.053] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:65:0)
[09:26:10.053] Timer tick, asking Buildbucket for the build status
[09:26:10.249] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:10.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:66:0) after 1m0s
[09:27:10.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:66:0)
[09:27:10.245] Timer tick, asking Buildbucket for the build status
[09:27:10.609] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:10.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:67:0) after 1m0s
[09:28:10.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:67:0)
[09:28:10.601] Timer tick, asking Buildbucket for the build status
[09:28:11.008] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:11.008] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:68:0) after 1m0s
[09:29:11.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:68:0)
[09:29:11.139] Timer tick, asking Buildbucket for the build status
[09:29:11.281] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:11.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:69:0) after 1m0s
[09:30:11.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:69:0)
[09:30:11.342] Timer tick, asking Buildbucket for the build status
[09:30:11.630] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:11.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:70:0) after 1m0s
[09:31:11.691] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:70:0)
[09:31:11.691] Timer tick, asking Buildbucket for the build status
[09:31:15.393] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:15.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:71:0) after 1m0s
[09:32:15.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:71:0)
[09:32:15.811] Timer tick, asking Buildbucket for the build status
[09:32:15.978] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:15.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:72:0) after 1m0s
[09:33:16.038] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:72:0)
[09:33:16.038] Timer tick, asking Buildbucket for the build status
[09:33:16.182] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:16.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:73:0) after 1m0s
[09:34:16.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:73:0)
[09:34:16.321] Timer tick, asking Buildbucket for the build status
[09:34:16.525] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:16.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:74:0) after 1m0s
[09:35:16.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:74:0)
[09:35:16.696] Timer tick, asking Buildbucket for the build status
[09:35:16.832] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:16.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:75:0) after 1m0s
[09:36:16.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:75:0)
[09:36:16.859] Timer tick, asking Buildbucket for the build status
[09:36:17.524] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:17.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:76:0) after 1m0s
[09:37:17.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:76:0)
[09:37:17.729] Timer tick, asking Buildbucket for the build status
[09:37:19.017] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:19.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:77:0) after 1m0s
[09:38:19.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:77:0)
[09:38:19.186] Timer tick, asking Buildbucket for the build status
[09:38:19.391] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:19.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:78:0) after 1m0s
[09:39:19.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:78:0)
[09:39:19.852] Timer tick, asking Buildbucket for the build status
[09:39:20.097] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:20.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:79:0) after 1m0s
[09:40:20.438] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:79:0)
[09:40:20.438] Timer tick, asking Buildbucket for the build status
[09:40:20.595] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:20.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:80:0) after 1m0s
[09:41:20.640] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:80:0)
[09:41:20.640] Timer tick, asking Buildbucket for the build status
[09:41:20.791] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:20.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:81:0) after 1m0s
[09:42:21.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:81:0)
[09:42:21.113] Timer tick, asking Buildbucket for the build status
[09:42:21.288] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:21.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:82:0) after 1m0s
[09:43:22.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:82:0)
[09:43:22.372] Timer tick, asking Buildbucket for the build status
[09:43:23.612] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:23.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:83:0) after 1m0s
[09:44:23.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:83:0)
[09:44:23.711] Timer tick, asking Buildbucket for the build status
[09:44:23.860] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:23.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:84:0) after 1m0s
[09:45:23.899] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:84:0)
[09:45:23.899] Timer tick, asking Buildbucket for the build status
[09:45:24.051] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:24.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:85:0) after 1m0s
[09:46:24.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:85:0)
[09:46:24.272] Timer tick, asking Buildbucket for the build status
[09:46:24.477] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:24.477] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:86:0) after 1m0s
[09:47:24.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:86:0)
[09:47:24.537] Timer tick, asking Buildbucket for the build status
[09:47:24.657] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:24.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:87:0) after 1m0s
[09:48:24.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:87:0)
[09:48:24.653] Timer tick, asking Buildbucket for the build status
[09:48:25.012] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:25.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:88:0) after 1m0s
[09:49:25.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:88:0)
[09:49:25.144] Timer tick, asking Buildbucket for the build status
[09:49:26.355] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:26.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:89:0) after 1m0s
[09:50:26.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:89:0)
[09:50:26.413] Timer tick, asking Buildbucket for the build status
[09:50:26.741] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:26.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:90:0) after 1m0s
[09:51:26.768] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:90:0)
[09:51:26.768] Timer tick, asking Buildbucket for the build status
[09:51:26.869] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:26.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:91:0) after 1m0s
[09:52:26.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:91:0)
[09:52:26.951] Timer tick, asking Buildbucket for the build status
[09:52:27.106] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:27.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:92:0) after 1m0s
[09:53:27.209] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:92:0)
[09:53:27.209] Timer tick, asking Buildbucket for the build status
[09:53:27.412] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:27.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:93:0) after 1m0s
[09:54:27.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:93:0)
[09:54:27.444] Timer tick, asking Buildbucket for the build status
[09:54:27.609] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:27.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:94:0) after 1m0s
[09:55:27.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:94:0)
[09:55:27.598] Timer tick, asking Buildbucket for the build status
[09:55:28.389] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:28.389] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:95:0) after 1m0s
[09:56:28.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:95:0)
[09:56:28.413] Timer tick, asking Buildbucket for the build status
[09:56:28.560] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:28.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:96:0) after 1m0s
[09:57:28.587] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:96:0)
[09:57:28.587] Timer tick, asking Buildbucket for the build status
[09:57:29.052] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:29.052] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:97:0) after 1m0s
[09:58:29.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:97:0)
[09:58:29.121] Timer tick, asking Buildbucket for the build status
[09:58:29.255] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:29.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:98:0) after 1m0s
[09:59:29.329] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:98:0)
[09:59:29.329] Timer tick, asking Buildbucket for the build status
[09:59:29.494] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:29.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:99:0) after 1m0s
[10:00:29.615] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:99:0)
[10:00:29.615] Timer tick, asking Buildbucket for the build status
[10:00:29.939] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:29.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:100:0) after 1m0s
[10:01:29.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:100:0)
[10:01:29.993] Timer tick, asking Buildbucket for the build status
[10:01:32.367] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:32.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:101:0) after 1m0s
[10:02:32.425] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:101:0)
[10:02:32.425] Timer tick, asking Buildbucket for the build status
[10:02:32.648] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:32.648] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:102:0) after 1m0s
[10:03:32.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:102:0)
[10:03:32.696] Timer tick, asking Buildbucket for the build status
[10:03:33.122] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:33.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:103:0) after 1m0s
[10:04:33.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:103:0)
[10:04:33.186] Timer tick, asking Buildbucket for the build status
[10:04:33.321] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:33.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:104:0) after 1m0s
[10:05:33.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:104:0)
[10:05:33.381] Timer tick, asking Buildbucket for the build status
[10:05:33.587] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:33.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:105:0) after 1m0s
[10:06:33.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:105:0)
[10:06:33.677] Timer tick, asking Buildbucket for the build status
[10:06:33.796] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:33.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:106:0) after 1m0s
[10:07:33.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:106:0)
[10:07:33.848] Timer tick, asking Buildbucket for the build status
[10:07:34.646] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:34.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:107:0) after 1m0s
[10:08:34.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:107:0)
[10:08:34.657] Timer tick, asking Buildbucket for the build status
[10:08:34.815] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:34.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:108:0) after 1m0s
[10:09:34.867] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:108:0)
[10:09:34.867] Timer tick, asking Buildbucket for the build status
[10:09:35.029] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:35.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:109:0) after 1m0s
[10:10:35.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:109:0)
[10:10:35.052] Timer tick, asking Buildbucket for the build status
[10:10:35.243] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:35.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:110:0) after 1m0s
[10:11:35.315] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:110:0)
[10:11:35.315] Timer tick, asking Buildbucket for the build status
[10:11:35.617] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:35.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:111:0) after 1m0s
[10:12:35.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:111:0)
[10:12:35.645] Timer tick, asking Buildbucket for the build status
[10:12:36.409] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:36.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:112:0) after 1m0s
[10:13:36.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:112:0)
[10:13:36.433] Timer tick, asking Buildbucket for the build status
[10:13:39.087] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:39.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:113:0) after 1m0s
[10:14:39.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:113:0)
[10:14:39.143] Timer tick, asking Buildbucket for the build status
[10:14:39.422] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:39.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:114:0) after 1m0s
[10:15:39.448] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:114:0)
[10:15:39.448] Timer tick, asking Buildbucket for the build status
[10:15:39.574] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:39.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:115:0) after 1m0s
[10:16:39.618] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:115:0)
[10:16:39.618] Timer tick, asking Buildbucket for the build status
[10:16:39.931] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:39.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:116:0) after 1m0s
[10:17:39.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:116:0)
[10:17:39.962] Timer tick, asking Buildbucket for the build status
[10:17:40.082] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:40.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:117:0) after 1m0s
[10:18:40.116] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:117:0)
[10:18:40.116] Timer tick, asking Buildbucket for the build status
[10:18:40.264] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:40.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:118:0) after 1m0s
[10:19:40.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:118:0)
[10:19:40.295] Timer tick, asking Buildbucket for the build status
[10:19:40.937] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:40.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:119:0) after 1m0s
[10:20:40.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:119:0)
[10:20:40.955] Timer tick, asking Buildbucket for the build status
[10:20:41.204] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:41.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:120:0) after 1m0s
[10:21:41.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:120:0)
[10:21:41.218] Timer tick, asking Buildbucket for the build status
[10:21:41.518] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:41.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:121:0) after 1m0s
[10:22:41.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:121:0)
[10:22:41.679] Timer tick, asking Buildbucket for the build status
[10:22:41.797] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:41.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:122:0) after 1m0s
[10:23:41.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:122:0)
[10:23:41.858] Timer tick, asking Buildbucket for the build status
[10:23:42.565] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:42.565] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:123:0) after 1m0s
[10:24:42.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:123:0)
[10:24:42.592] Timer tick, asking Buildbucket for the build status
[10:24:43.128] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:43.128] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:124:0) after 1m0s
[10:25:43.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:124:0)
[10:25:43.154] Timer tick, asking Buildbucket for the build status
[10:25:44.140] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:44.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:125:0) after 1m0s
[10:26:44.171] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:125:0)
[10:26:44.171] Timer tick, asking Buildbucket for the build status
[10:26:44.339] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:44.340] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:126:0) after 1m0s
[10:27:44.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:126:0)
[10:27:44.330] Timer tick, asking Buildbucket for the build status
[10:27:44.461] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:44.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:127:0) after 1m0s
[10:28:44.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:127:0)
[10:28:44.522] Timer tick, asking Buildbucket for the build status
[10:28:44.659] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:44.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:128:0) after 1m0s
[10:29:44.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:128:0)
[10:29:44.754] Timer tick, asking Buildbucket for the build status
[10:29:44.982] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:44.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:129:0) after 1m0s
[10:30:45.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:129:0)
[10:30:45.039] Timer tick, asking Buildbucket for the build status
[10:30:45.321] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:45.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:130:0) after 1m0s
[10:31:45.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:130:0)
[10:31:45.336] Timer tick, asking Buildbucket for the build status
[10:31:45.837] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:45.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:131:0) after 1m0s
[10:32:45.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:131:0)
[10:32:45.964] Timer tick, asking Buildbucket for the build status
[10:32:51.484] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:51.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:132:0) after 1m0s
[10:33:51.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:132:0)
[10:33:51.527] Timer tick, asking Buildbucket for the build status
[10:33:51.689] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:51.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:133:0) after 1m0s
[10:34:51.836] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:133:0)
[10:34:51.836] Timer tick, asking Buildbucket for the build status
[10:34:51.952] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:51.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:134:0) after 1m0s
[10:35:51.998] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:134:0)
[10:35:51.998] Timer tick, asking Buildbucket for the build status
[10:35:52.273] Build 8875266884412493920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:52.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040696946385526464:135:0) after 1m0s
[10:36:30.083] Received PubSub notification, asking Buildbucket for the build status
[10:36:30.148] Build 8875266884412493920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:36:30.148] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1594290988550748",
"created_by": "project:chromium",
"created_ts": "1594282943292561",
"id": "8875266884412493920",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b10e72a75c34b8a17754144690cd5dce8534437d\"}}",
"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-107-ki11\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 28489, \"got_angle_revision\": \"900c7e87ce707c081af72b51a5d08049a65c2fb8\", \"got_dawn_revision\": \"8a9919980f5417cd3df6e1bf6d9a3dc53762ad18\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"b10e72a75c34b8a17754144690cd5dce8534437d\", \"got_revision_cp\": \"refs/heads/master@{#786663}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"76cae97fc14cc95fb446335e2f70501f4ecc066c\", \"got_v8_revision\": \"e078f1d43a5ef91a701f1686917b6fac5176be85\", \"got_v8_revision_cp\": \"refs/heads/8.6.82@{#1}\", \"got_webrtc_revision\": \"18523c34b464600540b4b1f042d0d5519a5be953\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31682}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b10e72a75c34b8a17754144690cd5dce8534437d\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_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-central1-b-8-107-ki11\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1594282978485484",
"status": "COMPLETED",
"status_changed_ts": "1594290989152612",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28489",
"builder:Deterministic Linux",
"buildset:commit/git/b10e72a75c34b8a17754144690cd5dce8534437d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b10e72a75c34b8a17754144690cd5dce8534437d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040696946385526464",
"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/8875266884412493920/+/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:4d4b7caffa514a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1594290989398341",
"url": "https://ci.chromium.org/b/8875266884412493920",
"utcnow_ts": "1594290990141161"
}
}
[10:36:30.148] Invocation finished in 2h14m8.121572232s with status SUCCEEDED