[19:05:48.632] New invocation is queued and will start shortly
[19:05:49.913] Starting the invocation (attempt 1)
[19:05:50.013] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:05:50.013] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:05:50.013] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051256309513187904",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ccc84e77801c52146440264d619d6f5d64c54be9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9051256309513187904",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/ccc84e77801c52146440264d619d6f5d64c54be9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ccc84e77801c52146440264d619d6f5d64c54be9",
"gitiles_ref:refs/heads/master"
]
}
[19:05:50.984] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1584212750179856",
"id": "8885826247226866560",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ccc84e77801c52146440264d619d6f5d64c54be9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1584212750607410",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27166",
"builder:Deterministic Linux",
"buildset:commit/git/ccc84e77801c52146440264d619d6f5d64c54be9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ccc84e77801c52146440264d619d6f5d64c54be9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051256309513187904",
"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/8885826247226866560/+/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": "1584212750607514",
"url": "https://ci.chromium.org/b/8885826247226866560",
"utcnow_ts": "1584212750973128"
}
}
[19:05:50.984] Task URL: https://ci.chromium.org/b/8885826247226866560
[19:05:50.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:2:0) after 1m0s
[19:05:52.418] Received PubSub notification, asking Buildbucket for the build status
[19:05:52.484] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:51.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:2:0)
[19:06:51.104] Timer tick, asking Buildbucket for the build status
[19:06:51.327] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:51.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:4:0) after 1m0s
[19:07:51.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:4:0)
[19:07:51.383] Timer tick, asking Buildbucket for the build status
[19:07:51.480] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:51.480] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:5:0) after 1m0s
[19:08:51.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:5:0)
[19:08:51.542] Timer tick, asking Buildbucket for the build status
[19:08:51.661] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:51.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:6:0) after 1m0s
[19:09:51.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:6:0)
[19:09:51.697] Timer tick, asking Buildbucket for the build status
[19:09:51.962] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:51.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:7:0) after 1m0s
[19:10:52.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:7:0)
[19:10:52.041] Timer tick, asking Buildbucket for the build status
[19:10:52.179] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:52.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:8:0) after 1m0s
[19:11:52.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:8:0)
[19:11:52.200] Timer tick, asking Buildbucket for the build status
[19:11:52.553] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:52.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:9:0) after 1m0s
[19:12:52.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:9:0)
[19:12:52.642] Timer tick, asking Buildbucket for the build status
[19:12:52.739] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:52.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:10:0) after 1m0s
[19:13:52.727] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:10:0)
[19:13:52.727] Timer tick, asking Buildbucket for the build status
[19:13:52.882] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:52.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:11:0) after 1m0s
[19:14:52.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:11:0)
[19:14:52.948] Timer tick, asking Buildbucket for the build status
[19:14:53.053] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:53.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:12:0) after 1m0s
[19:15:53.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:12:0)
[19:15:53.201] Timer tick, asking Buildbucket for the build status
[19:15:53.341] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:53.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:13:0) after 1m0s
[19:16:53.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:13:0)
[19:16:53.444] Timer tick, asking Buildbucket for the build status
[19:16:53.745] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:53.745] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:14:0) after 1m0s
[19:17:53.870] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:14:0)
[19:17:53.870] Timer tick, asking Buildbucket for the build status
[19:17:53.981] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:53.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:15:0) after 1m0s
[19:18:54.147] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:15:0)
[19:18:54.147] Timer tick, asking Buildbucket for the build status
[19:18:54.341] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:54.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:16:0) after 1m0s
[19:19:54.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:16:0)
[19:19:54.365] Timer tick, asking Buildbucket for the build status
[19:19:54.499] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:54.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:17:0) after 1m0s
[19:20:54.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:17:0)
[19:20:54.563] Timer tick, asking Buildbucket for the build status
[19:20:54.952] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:54.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:18:0) after 1m0s
[19:21:55.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:18:0)
[19:21:55.075] Timer tick, asking Buildbucket for the build status
[19:21:55.213] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:55.213] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:19:0) after 1m0s
[19:22:55.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:19:0)
[19:22:55.266] Timer tick, asking Buildbucket for the build status
[19:22:55.454] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:55.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:20:0) after 1m0s
[19:23:55.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:20:0)
[19:23:55.482] Timer tick, asking Buildbucket for the build status
[19:23:55.609] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:55.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:21:0) after 1m0s
[19:24:55.635] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:21:0)
[19:24:55.635] Timer tick, asking Buildbucket for the build status
[19:24:55.761] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:55.761] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:22:0) after 1m0s
[19:25:55.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:22:0)
[19:25:55.824] Timer tick, asking Buildbucket for the build status
[19:25:56.056] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:56.056] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:23:0) after 1m0s
[19:26:56.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:23:0)
[19:26:56.199] Timer tick, asking Buildbucket for the build status
[19:26:56.339] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:56.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:24:0) after 1m0s
[19:27:56.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:24:0)
[19:27:56.471] Timer tick, asking Buildbucket for the build status
[19:27:56.634] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:56.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:25:0) after 1m0s
[19:28:56.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:25:0)
[19:28:56.656] Timer tick, asking Buildbucket for the build status
[19:28:56.813] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:56.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:26:0) after 1m0s
[19:29:56.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:26:0)
[19:29:56.831] Timer tick, asking Buildbucket for the build status
[19:29:56.966] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:56.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:27:0) after 1m0s
[19:30:57.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:27:0)
[19:30:57.059] Timer tick, asking Buildbucket for the build status
[19:30:57.229] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:57.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:28:0) after 1m0s
[19:31:57.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:28:0)
[19:31:57.363] Timer tick, asking Buildbucket for the build status
[19:31:57.600] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:57.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:29:0) after 1m0s
[19:32:57.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:29:0)
[19:32:57.829] Timer tick, asking Buildbucket for the build status
[19:32:58.005] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:58.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:30:0) after 1m0s
[19:33:58.125] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:30:0)
[19:33:58.125] Timer tick, asking Buildbucket for the build status
[19:33:58.257] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:58.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:31:0) after 1m0s
[19:34:58.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:31:0)
[19:34:58.331] Timer tick, asking Buildbucket for the build status
[19:34:58.458] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:58.458] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:32:0) after 1m0s
[19:35:58.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:32:0)
[19:35:58.528] Timer tick, asking Buildbucket for the build status
[19:35:58.609] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:58.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:33:0) after 1m0s
[19:36:58.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:33:0)
[19:36:58.643] Timer tick, asking Buildbucket for the build status
[19:36:58.746] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:58.746] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:34:0) after 1m0s
[19:37:58.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:34:0)
[19:37:58.824] Timer tick, asking Buildbucket for the build status
[19:37:58.944] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:58.944] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:35:0) after 1m0s
[19:38:59.002] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:35:0)
[19:38:59.002] Timer tick, asking Buildbucket for the build status
[19:38:59.154] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:59.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:36:0) after 1m0s
[19:39:59.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:36:0)
[19:39:59.313] Timer tick, asking Buildbucket for the build status
[19:39:59.428] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:59.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:37:0) after 1m0s
[19:40:59.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:37:0)
[19:40:59.496] Timer tick, asking Buildbucket for the build status
[19:40:59.629] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:59.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:38:0) after 1m0s
[19:41:59.690] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:38:0)
[19:41:59.690] Timer tick, asking Buildbucket for the build status
[19:41:59.816] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:59.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:39:0) after 1m0s
[19:42:59.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:39:0)
[19:42:59.817] Timer tick, asking Buildbucket for the build status
[19:42:59.930] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:59.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:40:0) after 1m0s
[19:43:59.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:40:0)
[19:43:59.950] Timer tick, asking Buildbucket for the build status
[19:44:00.199] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:00.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:41:0) after 1m0s
[19:45:00.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:41:0)
[19:45:00.266] Timer tick, asking Buildbucket for the build status
[19:45:00.536] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:00.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:42:0) after 1m0s
[19:46:00.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:42:0)
[19:46:00.622] Timer tick, asking Buildbucket for the build status
[19:46:00.921] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:00.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:43:0) after 1m0s
[19:47:01.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:43:0)
[19:47:01.102] Timer tick, asking Buildbucket for the build status
[19:47:01.268] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:01.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:44:0) after 1m0s
[19:48:01.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:44:0)
[19:48:01.388] Timer tick, asking Buildbucket for the build status
[19:48:01.495] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:01.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:45:0) after 1m0s
[19:49:01.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:45:0)
[19:49:01.573] Timer tick, asking Buildbucket for the build status
[19:49:01.819] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:01.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:46:0) after 1m0s
[19:50:01.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:46:0)
[19:50:01.895] Timer tick, asking Buildbucket for the build status
[19:50:02.194] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:02.194] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:47:0) after 1m0s
[19:51:02.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:47:0)
[19:51:02.262] Timer tick, asking Buildbucket for the build status
[19:51:02.791] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:02.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:48:0) after 1m0s
[19:52:02.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:48:0)
[19:52:02.894] Timer tick, asking Buildbucket for the build status
[19:52:03.041] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:03.041] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:49:0) after 1m0s
[19:53:03.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:49:0)
[19:53:03.115] Timer tick, asking Buildbucket for the build status
[19:53:04.498] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:04.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:50:0) after 1m0s
[19:54:04.566] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:50:0)
[19:54:04.566] Timer tick, asking Buildbucket for the build status
[19:54:04.720] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:04.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:51:0) after 1m0s
[19:55:04.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:51:0)
[19:55:04.829] Timer tick, asking Buildbucket for the build status
[19:55:05.617] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:05.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:52:0) after 1m0s
[19:56:05.636] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:52:0)
[19:56:05.636] Timer tick, asking Buildbucket for the build status
[19:56:05.779] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:05.779] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:53:0) after 1m0s
[19:57:05.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:53:0)
[19:57:05.799] Timer tick, asking Buildbucket for the build status
[19:57:05.942] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:05.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:54:0) after 1m0s
[19:58:05.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:54:0)
[19:58:05.970] Timer tick, asking Buildbucket for the build status
[19:58:06.089] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:06.089] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:55:0) after 1m0s
[19:59:06.158] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:55:0)
[19:59:06.158] Timer tick, asking Buildbucket for the build status
[19:59:06.259] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:06.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:56:0) after 1m0s
[20:00:06.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:56:0)
[20:00:06.288] Timer tick, asking Buildbucket for the build status
[20:00:06.444] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:06.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:57:0) after 1m0s
[20:01:06.863] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:57:0)
[20:01:06.863] Timer tick, asking Buildbucket for the build status
[20:01:07.006] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:07.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:58:0) after 1m0s
[20:02:07.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:58:0)
[20:02:07.192] Timer tick, asking Buildbucket for the build status
[20:02:07.339] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:07.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:59:0) after 1m0s
[20:03:07.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:59:0)
[20:03:07.460] Timer tick, asking Buildbucket for the build status
[20:03:07.616] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:07.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:60:0) after 1m0s
[20:04:07.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:60:0)
[20:04:07.742] Timer tick, asking Buildbucket for the build status
[20:04:07.895] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:07.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:61:0) after 1m0s
[20:05:07.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:61:0)
[20:05:07.968] Timer tick, asking Buildbucket for the build status
[20:05:08.122] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:08.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:62:0) after 1m0s
[20:06:08.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:62:0)
[20:06:08.197] Timer tick, asking Buildbucket for the build status
[20:06:08.412] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:08.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:63:0) after 1m0s
[20:07:08.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:63:0)
[20:07:08.479] Timer tick, asking Buildbucket for the build status
[20:07:08.588] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:08.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:64:0) after 1m0s
[20:08:08.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:64:0)
[20:08:08.626] Timer tick, asking Buildbucket for the build status
[20:08:08.866] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:08.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:65:0) after 1m0s
[20:09:08.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:65:0)
[20:09:08.862] Timer tick, asking Buildbucket for the build status
[20:09:09.355] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:09.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:66:0) after 1m0s
[20:10:09.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:66:0)
[20:10:09.444] Timer tick, asking Buildbucket for the build status
[20:10:10.144] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:10.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:67:0) after 1m0s
[20:11:10.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:67:0)
[20:11:10.217] Timer tick, asking Buildbucket for the build status
[20:11:10.369] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:10.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:68:0) after 1m0s
[20:12:10.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:68:0)
[20:12:10.488] Timer tick, asking Buildbucket for the build status
[20:12:10.630] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:10.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:69:0) after 1m0s
[20:13:10.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:69:0)
[20:13:10.650] Timer tick, asking Buildbucket for the build status
[20:13:10.789] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:10.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:70:0) after 1m0s
[20:14:10.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:70:0)
[20:14:10.893] Timer tick, asking Buildbucket for the build status
[20:14:11.032] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:11.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:71:0) after 1m0s
[20:15:11.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:71:0)
[20:15:11.197] Timer tick, asking Buildbucket for the build status
[20:15:11.347] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:11.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:72:0) after 1m0s
[20:16:11.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:72:0)
[20:16:11.452] Timer tick, asking Buildbucket for the build status
[20:16:11.623] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:11.623] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:73:0) after 1m0s
[20:17:11.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:73:0)
[20:17:11.629] Timer tick, asking Buildbucket for the build status
[20:17:11.937] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:11.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:74:0) after 1m0s
[20:18:12.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:74:0)
[20:18:12.009] Timer tick, asking Buildbucket for the build status
[20:18:12.373] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:12.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:75:0) after 1m0s
[20:19:12.393] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:75:0)
[20:19:12.393] Timer tick, asking Buildbucket for the build status
[20:19:12.520] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:12.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:76:0) after 1m0s
[20:20:12.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:76:0)
[20:20:12.552] Timer tick, asking Buildbucket for the build status
[20:20:12.689] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:12.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:77:0) after 1m0s
[20:21:12.708] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:77:0)
[20:21:12.708] Timer tick, asking Buildbucket for the build status
[20:21:12.834] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:12.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:78:0) after 1m0s
[20:22:12.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:78:0)
[20:22:12.925] Timer tick, asking Buildbucket for the build status
[20:22:15.112] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:15.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:79:0) after 1m0s
[20:23:15.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:79:0)
[20:23:15.105] Timer tick, asking Buildbucket for the build status
[20:23:15.236] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:15.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:80:0) after 1m0s
[20:24:15.253] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:80:0)
[20:24:15.253] Timer tick, asking Buildbucket for the build status
[20:24:15.368] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:15.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:81:0) after 1m0s
[20:25:15.403] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:81:0)
[20:25:15.403] Timer tick, asking Buildbucket for the build status
[20:25:15.513] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:15.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:82:0) after 1m0s
[20:26:15.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:82:0)
[20:26:15.607] Timer tick, asking Buildbucket for the build status
[20:26:15.717] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:15.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:83:0) after 1m0s
[20:27:15.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:83:0)
[20:27:15.743] Timer tick, asking Buildbucket for the build status
[20:27:15.891] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:15.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:84:0) after 1m0s
[20:28:15.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:84:0)
[20:28:15.950] Timer tick, asking Buildbucket for the build status
[20:28:16.284] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:16.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:85:0) after 1m0s
[20:29:16.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:85:0)
[20:29:16.442] Timer tick, asking Buildbucket for the build status
[20:29:16.810] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:16.810] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:86:0) after 1m0s
[20:30:16.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:86:0)
[20:30:16.939] Timer tick, asking Buildbucket for the build status
[20:30:17.117] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:17.117] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:87:0) after 1m0s
[20:31:17.241] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:87:0)
[20:31:17.241] Timer tick, asking Buildbucket for the build status
[20:31:17.477] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:17.477] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:88:0) after 1m0s
[20:32:17.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:88:0)
[20:32:17.532] Timer tick, asking Buildbucket for the build status
[20:32:17.869] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:17.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:89:0) after 1m0s
[20:33:17.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:89:0)
[20:33:17.943] Timer tick, asking Buildbucket for the build status
[20:33:18.040] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:18.040] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:90:0) after 1m0s
[20:34:18.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:90:0)
[20:34:18.164] Timer tick, asking Buildbucket for the build status
[20:34:18.547] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:18.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:91:0) after 1m0s
[20:35:18.594] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:91:0)
[20:35:18.594] Timer tick, asking Buildbucket for the build status
[20:35:18.741] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:18.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:92:0) after 1m0s
[20:36:18.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:92:0)
[20:36:18.846] Timer tick, asking Buildbucket for the build status
[20:36:19.019] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:19.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:93:0) after 1m0s
[20:37:19.174] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:93:0)
[20:37:19.174] Timer tick, asking Buildbucket for the build status
[20:37:19.274] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:19.274] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:94:0) after 1m0s
[20:38:19.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:94:0)
[20:38:19.547] Timer tick, asking Buildbucket for the build status
[20:38:19.711] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:19.711] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:95:0) after 1m0s
[20:39:19.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:95:0)
[20:39:19.854] Timer tick, asking Buildbucket for the build status
[20:39:20.073] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:20.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:96:0) after 1m0s
[20:40:20.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:96:0)
[20:40:20.122] Timer tick, asking Buildbucket for the build status
[20:40:20.339] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:20.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:97:0) after 1m0s
[20:41:20.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:97:0)
[20:41:20.429] Timer tick, asking Buildbucket for the build status
[20:41:20.640] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:20.640] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:98:0) after 1m0s
[20:42:20.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:98:0)
[20:42:20.715] Timer tick, asking Buildbucket for the build status
[20:42:20.817] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:20.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:99:0) after 1m0s
[20:43:20.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:99:0)
[20:43:20.971] Timer tick, asking Buildbucket for the build status
[20:43:21.091] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:21.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:100:0) after 1m0s
[20:44:21.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:100:0)
[20:44:21.272] Timer tick, asking Buildbucket for the build status
[20:44:21.530] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:21.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:101:0) after 1m0s
[20:45:21.703] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:101:0)
[20:45:21.703] Timer tick, asking Buildbucket for the build status
[20:45:21.813] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:21.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:102:0) after 1m0s
[20:46:21.865] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:102:0)
[20:46:21.865] Timer tick, asking Buildbucket for the build status
[20:46:22.031] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:22.031] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:103:0) after 1m0s
[20:47:22.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:103:0)
[20:47:22.128] Timer tick, asking Buildbucket for the build status
[20:47:22.855] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:22.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:104:0) after 1m0s
[20:48:22.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:104:0)
[20:48:22.855] Timer tick, asking Buildbucket for the build status
[20:48:23.266] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:23.266] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:105:0) after 1m0s
[20:49:23.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:105:0)
[20:49:23.286] Timer tick, asking Buildbucket for the build status
[20:49:23.430] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:23.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:106:0) after 1m0s
[20:50:23.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:106:0)
[20:50:23.454] Timer tick, asking Buildbucket for the build status
[20:50:23.560] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:23.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:107:0) after 1m0s
[20:51:23.587] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:107:0)
[20:51:23.587] Timer tick, asking Buildbucket for the build status
[20:51:23.896] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:23.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:108:0) after 1m0s
[20:52:23.873] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:108:0)
[20:52:23.873] Timer tick, asking Buildbucket for the build status
[20:52:23.979] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:23.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:109:0) after 1m0s
[20:53:24.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:109:0)
[20:53:24.029] Timer tick, asking Buildbucket for the build status
[20:53:24.180] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:24.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:110:0) after 1m0s
[20:54:24.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:110:0)
[20:54:24.221] Timer tick, asking Buildbucket for the build status
[20:54:25.004] Build 8885826247226866560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:25.004] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9051256309513187904:111:0) after 1m0s
[20:55:04.839] Received PubSub notification, asking Buildbucket for the build status
[20:55:04.917] Build 8885826247226866560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:55:04.917] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1584219303307438",
"created_by": "project:chromium",
"created_ts": "1584212750179856",
"id": "8885826247226866560",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ccc84e77801c52146440264d619d6f5d64c54be9\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-36-isdx\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27166, \"got_angle_revision\": \"a3cf06ac1718de5cee0c84891e2ac7fc3bfbe92a\", \"got_dawn_revision\": \"463c394905997cda256fda9f2980acd99f2de09a\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"ccc84e77801c52146440264d619d6f5d64c54be9\", \"got_revision_cp\": \"refs/heads/master@{#750407}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"3a50a43df988b2d375a1247073329fb9ad64bca0\", \"got_v8_revision\": \"506142ad90f3a4d686c6367f4a720f53eeae38af\", \"got_v8_revision_cp\": \"refs/heads/8.2.297@{#1}\", \"got_webrtc_revision\": \"86eb5d9703db177bfcb7c85617d4551f5f9b9490\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30787}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ccc84e77801c52146440264d619d6f5d64c54be9\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_016577e073ce9abf0fa10d80f88bc2caf8f81662b409bd6e59fa52089e44a3df_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_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-east1-d-8-36-isdx\"], \"image\": [\"chrome-xenial-20030800-300841f894e\"], \"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\": [\"4874-3598771\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1584212751416976",
"status": "COMPLETED",
"status_changed_ts": "1584219303581081",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27166",
"builder:Deterministic Linux",
"buildset:commit/git/ccc84e77801c52146440264d619d6f5d64c54be9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ccc84e77801c52146440264d619d6f5d64c54be9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051256309513187904",
"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/8885826247226866560/+/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:4af341ba4d532710",
"user_agent:luci-scheduler"
],
"updated_ts": "1584219303590204",
"url": "https://ci.chromium.org/b/8885826247226866560",
"utcnow_ts": "1584219304909065"
}
}
[20:55:04.917] Invocation finished in 1h49m16.302391049s with status SUCCEEDED