[16:38:18.566] New invocation is queued and will start shortly
[16:38:19.746] Starting the invocation (attempt 1)
[16:38:19.887] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:38:19.888] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:38:19.888] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050993798578027248",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"49227d673b49cfdca716c26c31d10b9b50d0b17b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9050993798578027248",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/49227d673b49cfdca716c26c31d10b9b50d0b17b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49227d673b49cfdca716c26c31d10b9b50d0b17b",
"gitiles_ref:refs/heads/master"
]
}
[16:38:21.612] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1584463100063744",
"id": "8885563736346961072",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49227d673b49cfdca716c26c31d10b9b50d0b17b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1584463101258264",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27200",
"builder:Deterministic Linux",
"buildset:commit/git/49227d673b49cfdca716c26c31d10b9b50d0b17b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49227d673b49cfdca716c26c31d10b9b50d0b17b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050993798578027248",
"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/8885563736346961072/+/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": "1584463101258443",
"url": "https://ci.chromium.org/b/8885563736346961072",
"utcnow_ts": "1584463101596555"
}
}
[16:38:21.612] Task URL: https://ci.chromium.org/b/8885563736346961072
[16:38:21.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:2:0) after 1m0s
[16:38:25.551] Received PubSub notification, asking Buildbucket for the build status
[16:38:25.681] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:21.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:2:0)
[16:39:21.683] Timer tick, asking Buildbucket for the build status
[16:39:21.824] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:21.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:4:0) after 1m0s
[16:40:22.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:4:0)
[16:40:22.043] Timer tick, asking Buildbucket for the build status
[16:40:22.241] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:22.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:5:0) after 1m0s
[16:41:22.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:5:0)
[16:41:22.224] Timer tick, asking Buildbucket for the build status
[16:41:22.530] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:22.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:6:0) after 1m0s
[16:42:22.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:6:0)
[16:42:22.581] Timer tick, asking Buildbucket for the build status
[16:42:22.784] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:22.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:7:0) after 1m0s
[16:43:22.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:7:0)
[16:43:22.806] Timer tick, asking Buildbucket for the build status
[16:43:23.074] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:23.074] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:8:0) after 1m0s
[16:44:23.085] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:8:0)
[16:44:23.085] Timer tick, asking Buildbucket for the build status
[16:44:23.340] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:23.340] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:9:0) after 1m0s
[16:45:23.369] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:9:0)
[16:45:23.369] Timer tick, asking Buildbucket for the build status
[16:45:23.678] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:23.678] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:10:0) after 1m0s
[16:46:23.698] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:10:0)
[16:46:23.698] Timer tick, asking Buildbucket for the build status
[16:46:24.045] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:24.045] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:11:0) after 1m0s
[16:47:24.050] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:11:0)
[16:47:24.050] Timer tick, asking Buildbucket for the build status
[16:47:25.277] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:25.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:12:0) after 1m0s
[16:48:25.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:12:0)
[16:48:25.299] Timer tick, asking Buildbucket for the build status
[16:48:25.677] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:25.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:13:0) after 1m0s
[16:49:25.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:13:0)
[16:49:25.750] Timer tick, asking Buildbucket for the build status
[16:49:26.399] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:26.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:14:0) after 1m0s
[16:50:26.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:14:0)
[16:50:26.454] Timer tick, asking Buildbucket for the build status
[16:50:27.960] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:27.960] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:15:0) after 1m0s
[16:51:27.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:15:0)
[16:51:27.993] Timer tick, asking Buildbucket for the build status
[16:51:28.150] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:28.151] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:16:0) after 1m0s
[16:52:28.182] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:16:0)
[16:52:28.182] Timer tick, asking Buildbucket for the build status
[16:52:29.441] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:29.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:17:0) after 1m0s
[16:53:29.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:17:0)
[16:53:29.495] Timer tick, asking Buildbucket for the build status
[16:53:29.627] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:29.627] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:18:0) after 1m0s
[16:54:29.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:18:0)
[16:54:29.662] Timer tick, asking Buildbucket for the build status
[16:54:30.026] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:30.026] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:19:0) after 1m0s
[16:55:30.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:19:0)
[16:55:30.025] Timer tick, asking Buildbucket for the build status
[16:55:30.868] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:30.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:20:0) after 1m0s
[16:56:30.905] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:20:0)
[16:56:30.905] Timer tick, asking Buildbucket for the build status
[16:56:31.346] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:31.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:21:0) after 1m0s
[16:57:31.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:21:0)
[16:57:31.371] Timer tick, asking Buildbucket for the build status
[16:57:31.782] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:31.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:22:0) after 1m0s
[16:58:31.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:22:0)
[16:58:31.822] Timer tick, asking Buildbucket for the build status
[16:58:32.057] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:32.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:23:0) after 1m0s
[16:59:32.110] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:23:0)
[16:59:32.110] Timer tick, asking Buildbucket for the build status
[16:59:33.913] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:33.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:24:0) after 1m0s
[17:00:33.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:24:0)
[17:00:33.955] Timer tick, asking Buildbucket for the build status
[17:00:34.158] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:34.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:25:0) after 1m0s
[17:01:34.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:25:0)
[17:01:34.197] Timer tick, asking Buildbucket for the build status
[17:01:34.553] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:34.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:26:0) after 1m0s
[17:02:34.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:26:0)
[17:02:34.646] Timer tick, asking Buildbucket for the build status
[17:02:35.273] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:35.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:27:0) after 1m0s
[17:03:35.339] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:27:0)
[17:03:35.339] Timer tick, asking Buildbucket for the build status
[17:03:36.621] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:36.621] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:28:0) after 1m0s
[17:04:36.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:28:0)
[17:04:36.701] Timer tick, asking Buildbucket for the build status
[17:04:38.103] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:29:0) after 1m0s
[17:05:38.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:29:0)
[17:05:38.156] Timer tick, asking Buildbucket for the build status
[17:05:38.609] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:38.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:30:0) after 1m0s
[17:06:38.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:30:0)
[17:06:38.717] Timer tick, asking Buildbucket for the build status
[17:06:39.218] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:39.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:31:0) after 1m0s
[17:07:39.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:31:0)
[17:07:39.247] Timer tick, asking Buildbucket for the build status
[17:07:39.979] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:39.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:32:0) after 1m0s
[17:08:40.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:32:0)
[17:08:40.050] Timer tick, asking Buildbucket for the build status
[17:08:40.213] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:40.213] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:33:0) after 1m0s
[17:09:40.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:33:0)
[17:09:40.268] Timer tick, asking Buildbucket for the build status
[17:09:40.568] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:40.568] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:34:0) after 1m0s
[17:10:40.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:34:0)
[17:10:40.588] Timer tick, asking Buildbucket for the build status
[17:10:40.968] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:40.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:35:0) after 1m0s
[17:11:41.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:35:0)
[17:11:41.022] Timer tick, asking Buildbucket for the build status
[17:11:41.554] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:41.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:36:0) after 1m0s
[17:12:41.545] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:36:0)
[17:12:41.545] Timer tick, asking Buildbucket for the build status
[17:12:41.925] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:41.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:37:0) after 1m0s
[17:13:42.042] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:37:0)
[17:13:42.042] Timer tick, asking Buildbucket for the build status
[17:13:42.444] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:42.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:38:0) after 1m0s
[17:14:42.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:38:0)
[17:14:42.514] Timer tick, asking Buildbucket for the build status
[17:14:43.020] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:43.020] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:39:0) after 1m0s
[17:15:43.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:39:0)
[17:15:43.071] Timer tick, asking Buildbucket for the build status
[17:15:44.173] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:44.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:40:0) after 1m0s
[17:16:44.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:40:0)
[17:16:44.212] Timer tick, asking Buildbucket for the build status
[17:16:44.705] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:44.705] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:41:0) after 1m0s
[17:17:44.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:41:0)
[17:17:44.757] Timer tick, asking Buildbucket for the build status
[17:17:46.016] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:46.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:42:0) after 1m0s
[17:18:46.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:42:0)
[17:18:46.059] Timer tick, asking Buildbucket for the build status
[17:18:46.281] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:46.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:43:0) after 1m0s
[17:19:46.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:43:0)
[17:19:46.282] Timer tick, asking Buildbucket for the build status
[17:19:46.548] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:46.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:44:0) after 1m0s
[17:20:46.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:44:0)
[17:20:46.584] Timer tick, asking Buildbucket for the build status
[17:20:47.522] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:47.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:45:0) after 1m0s
[17:21:47.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:45:0)
[17:21:47.631] Timer tick, asking Buildbucket for the build status
[17:21:47.980] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:47.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:46:0) after 1m0s
[17:22:48.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:46:0)
[17:22:48.018] Timer tick, asking Buildbucket for the build status
[17:22:48.409] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:48.410] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:47:0) after 1m0s
[17:23:48.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:47:0)
[17:23:48.449] Timer tick, asking Buildbucket for the build status
[17:23:50.001] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:50.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:48:0) after 1m0s
[17:24:50.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:48:0)
[17:24:50.046] Timer tick, asking Buildbucket for the build status
[17:24:50.215] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:50.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:49:0) after 1m0s
[17:25:50.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:49:0)
[17:25:50.280] Timer tick, asking Buildbucket for the build status
[17:25:50.893] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:50.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:50:0) after 1m0s
[17:26:50.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:50:0)
[17:26:50.979] Timer tick, asking Buildbucket for the build status
[17:26:51.300] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:51.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:51:0) after 1m0s
[17:27:51.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:51:0)
[17:27:51.359] Timer tick, asking Buildbucket for the build status
[17:27:51.475] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:51.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:52:0) after 1m0s
[17:28:51.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:52:0)
[17:28:51.675] Timer tick, asking Buildbucket for the build status
[17:28:52.351] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:52.351] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:53:0) after 1m0s
[17:29:52.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:53:0)
[17:29:52.373] Timer tick, asking Buildbucket for the build status
[17:29:52.761] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:52.761] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:54:0) after 1m0s
[17:30:52.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:54:0)
[17:30:52.784] Timer tick, asking Buildbucket for the build status
[17:30:53.468] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:53.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:55:0) after 1m0s
[17:31:53.437] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:55:0)
[17:31:53.437] Timer tick, asking Buildbucket for the build status
[17:31:54.131] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:54.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:56:0) after 1m0s
[17:32:54.182] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:56:0)
[17:32:54.182] Timer tick, asking Buildbucket for the build status
[17:32:54.471] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:54.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:57:0) after 1m0s
[17:33:54.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:57:0)
[17:33:54.513] Timer tick, asking Buildbucket for the build status
[17:33:54.745] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:54.745] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:58:0) after 1m0s
[17:34:54.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:58:0)
[17:34:54.788] Timer tick, asking Buildbucket for the build status
[17:34:55.032] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:55.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:59:0) after 1m0s
[17:35:55.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:59:0)
[17:35:55.057] Timer tick, asking Buildbucket for the build status
[17:35:55.255] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:55.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:60:0) after 1m0s
[17:36:55.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:60:0)
[17:36:55.268] Timer tick, asking Buildbucket for the build status
[17:36:55.481] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:55.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:61:0) after 1m0s
[17:37:55.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:61:0)
[17:37:55.569] Timer tick, asking Buildbucket for the build status
[17:37:56.178] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:56.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:62:0) after 1m0s
[17:38:56.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:62:0)
[17:38:56.278] Timer tick, asking Buildbucket for the build status
[17:38:56.367] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:56.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:63:0) after 1m0s
[17:39:56.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:63:0)
[17:39:56.411] Timer tick, asking Buildbucket for the build status
[17:39:57.865] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:57.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:64:0) after 1m0s
[17:40:57.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:64:0)
[17:40:57.922] Timer tick, asking Buildbucket for the build status
[17:40:58.812] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:58.812] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:65:0) after 1m0s
[17:41:58.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:65:0)
[17:41:58.831] Timer tick, asking Buildbucket for the build status
[17:41:58.990] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:58.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:66:0) after 1m0s
[17:42:59.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:66:0)
[17:42:59.045] Timer tick, asking Buildbucket for the build status
[17:43:01.844] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:01.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:67:0) after 1m0s
[17:44:01.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:67:0)
[17:44:01.923] Timer tick, asking Buildbucket for the build status
[17:44:02.074] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:02.074] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:68:0) after 1m0s
[17:45:02.119] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:68:0)
[17:45:02.119] Timer tick, asking Buildbucket for the build status
[17:45:03.691] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:03.691] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:69:0) after 1m0s
[17:46:03.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:69:0)
[17:46:03.792] Timer tick, asking Buildbucket for the build status
[17:46:05.443] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:05.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:70:0) after 1m0s
[17:47:05.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:70:0)
[17:47:05.581] Timer tick, asking Buildbucket for the build status
[17:47:07.306] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:07.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:71:0) after 1m0s
[17:48:07.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:71:0)
[17:48:07.298] Timer tick, asking Buildbucket for the build status
[17:48:07.575] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:07.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:72:0) after 1m0s
[17:49:07.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:72:0)
[17:49:07.788] Timer tick, asking Buildbucket for the build status
[17:49:07.963] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:07.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:73:0) after 1m0s
[17:50:08.019] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:73:0)
[17:50:08.019] Timer tick, asking Buildbucket for the build status
[17:50:09.354] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:09.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:74:0) after 1m0s
[17:51:09.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:74:0)
[17:51:09.381] Timer tick, asking Buildbucket for the build status
[17:51:09.885] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:09.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:75:0) after 1m0s
[17:52:10.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:75:0)
[17:52:10.086] Timer tick, asking Buildbucket for the build status
[17:52:10.460] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:10.460] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:76:0) after 1m0s
[17:53:10.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:76:0)
[17:53:10.492] Timer tick, asking Buildbucket for the build status
[17:53:11.136] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:11.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:77:0) after 1m0s
[17:54:11.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:77:0)
[17:54:11.213] Timer tick, asking Buildbucket for the build status
[17:54:11.377] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:11.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:78:0) after 1m0s
[17:55:11.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:78:0)
[17:55:11.527] Timer tick, asking Buildbucket for the build status
[17:55:11.645] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:11.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:79:0) after 1m0s
[17:56:11.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:79:0)
[17:56:11.656] Timer tick, asking Buildbucket for the build status
[17:56:12.443] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:12.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:80:0) after 1m0s
[17:57:12.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:80:0)
[17:57:12.597] Timer tick, asking Buildbucket for the build status
[17:57:12.902] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:12.902] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:81:0) after 1m0s
[17:58:13.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:81:0)
[17:58:13.145] Timer tick, asking Buildbucket for the build status
[17:58:15.884] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:15.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:82:0) after 1m0s
[17:59:15.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:82:0)
[17:59:15.950] Timer tick, asking Buildbucket for the build status
[17:59:16.757] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:16.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:83:0) after 1m0s
[18:00:16.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:83:0)
[18:00:16.808] Timer tick, asking Buildbucket for the build status
[18:00:17.066] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:17.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:84:0) after 1m0s
[18:01:17.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:84:0)
[18:01:17.137] Timer tick, asking Buildbucket for the build status
[18:01:17.274] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:17.274] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:85:0) after 1m0s
[18:02:17.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:85:0)
[18:02:17.311] Timer tick, asking Buildbucket for the build status
[18:02:17.987] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:17.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:86:0) after 1m0s
[18:03:18.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:86:0)
[18:03:18.099] Timer tick, asking Buildbucket for the build status
[18:03:20.945] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:20.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:87:0) after 1m0s
[18:04:21.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:87:0)
[18:04:21.052] Timer tick, asking Buildbucket for the build status
[18:04:21.890] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:21.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:88:0) after 1m0s
[18:05:21.969] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:88:0)
[18:05:21.969] Timer tick, asking Buildbucket for the build status
[18:05:23.450] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:23.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:89:0) after 1m0s
[18:06:23.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:89:0)
[18:06:23.496] Timer tick, asking Buildbucket for the build status
[18:06:23.715] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:23.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:90:0) after 1m0s
[18:07:23.783] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:90:0)
[18:07:23.783] Timer tick, asking Buildbucket for the build status
[18:07:23.941] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:23.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:91:0) after 1m0s
[18:08:23.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:91:0)
[18:08:23.967] Timer tick, asking Buildbucket for the build status
[18:08:24.847] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:24.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:92:0) after 1m0s
[18:09:24.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:92:0)
[18:09:24.875] Timer tick, asking Buildbucket for the build status
[18:09:26.147] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:26.147] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:93:0) after 1m0s
[18:10:26.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:93:0)
[18:10:26.473] Timer tick, asking Buildbucket for the build status
[18:10:26.637] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:26.637] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:94:0) after 1m0s
[18:11:26.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:94:0)
[18:11:26.648] Timer tick, asking Buildbucket for the build status
[18:11:26.896] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:26.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:95:0) after 1m0s
[18:12:26.926] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:95:0)
[18:12:26.926] Timer tick, asking Buildbucket for the build status
[18:12:28.355] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:28.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:96:0) after 1m0s
[18:13:28.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:96:0)
[18:13:28.409] Timer tick, asking Buildbucket for the build status
[18:13:28.576] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:28.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:97:0) after 1m0s
[18:14:28.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:97:0)
[18:14:28.668] Timer tick, asking Buildbucket for the build status
[18:14:29.882] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:29.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:98:0) after 1m0s
[18:15:29.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:98:0)
[18:15:29.963] Timer tick, asking Buildbucket for the build status
[18:15:30.275] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:30.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:99:0) after 1m0s
[18:16:30.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:99:0)
[18:16:30.394] Timer tick, asking Buildbucket for the build status
[18:16:34.103] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:34.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:100:0) after 1m0s
[18:17:34.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:100:0)
[18:17:34.248] Timer tick, asking Buildbucket for the build status
[18:17:34.668] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:34.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:101:0) after 1m0s
[18:18:34.670] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:101:0)
[18:18:34.670] Timer tick, asking Buildbucket for the build status
[18:18:35.913] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:35.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:102:0) after 1m0s
[18:19:35.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:102:0)
[18:19:35.987] Timer tick, asking Buildbucket for the build status
[18:19:36.598] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:36.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:103:0) after 1m0s
[18:20:36.712] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:103:0)
[18:20:36.712] Timer tick, asking Buildbucket for the build status
[18:20:41.411] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:41.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:104:0) after 1m0s
[18:21:41.469] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:104:0)
[18:21:41.469] Timer tick, asking Buildbucket for the build status
[18:21:42.623] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:42.623] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:105:0) after 1m0s
[18:22:42.615] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:105:0)
[18:22:42.615] Timer tick, asking Buildbucket for the build status
[18:22:43.121] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:43.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:106:0) after 1m0s
[18:23:43.204] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:106:0)
[18:23:43.204] Timer tick, asking Buildbucket for the build status
[18:23:43.538] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:43.538] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:107:0) after 1m0s
[18:24:43.620] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:107:0)
[18:24:43.620] Timer tick, asking Buildbucket for the build status
[18:24:44.859] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:44.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:108:0) after 1m0s
[18:25:45.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:108:0)
[18:25:45.029] Timer tick, asking Buildbucket for the build status
[18:25:45.295] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:45.295] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:109:0) after 1m0s
[18:26:45.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:109:0)
[18:26:45.299] Timer tick, asking Buildbucket for the build status
[18:26:45.426] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:45.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:110:0) after 1m0s
[18:27:45.461] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:110:0)
[18:27:45.461] Timer tick, asking Buildbucket for the build status
[18:27:45.945] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:45.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:111:0) after 1m0s
[18:28:46.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:111:0)
[18:28:46.022] Timer tick, asking Buildbucket for the build status
[18:28:47.368] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:47.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:112:0) after 1m0s
[18:29:47.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:112:0)
[18:29:47.466] Timer tick, asking Buildbucket for the build status
[18:29:49.067] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:49.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:113:0) after 1m0s
[18:30:49.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:113:0)
[18:30:49.078] Timer tick, asking Buildbucket for the build status
[18:30:49.316] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:49.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:114:0) after 1m0s
[18:31:49.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:114:0)
[18:31:49.436] Timer tick, asking Buildbucket for the build status
[18:31:49.537] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:49.537] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:115:0) after 1m0s
[18:32:49.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:115:0)
[18:32:49.669] Timer tick, asking Buildbucket for the build status
[18:32:50.136] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:50.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:116:0) after 1m0s
[18:33:50.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:116:0)
[18:33:50.188] Timer tick, asking Buildbucket for the build status
[18:33:50.346] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:50.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:117:0) after 1m0s
[18:34:50.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:117:0)
[18:34:50.395] Timer tick, asking Buildbucket for the build status
[18:34:50.782] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:50.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:118:0) after 1m0s
[18:35:50.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:118:0)
[18:35:50.835] Timer tick, asking Buildbucket for the build status
[18:35:52.097] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:52.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:119:0) after 1m0s
[18:36:52.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:119:0)
[18:36:52.189] Timer tick, asking Buildbucket for the build status
[18:36:52.752] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:52.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:120:0) after 1m0s
[18:37:52.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:120:0)
[18:37:52.874] Timer tick, asking Buildbucket for the build status
[18:37:53.346] Build 8885563736346961072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:53.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050993798578027248:121:0) after 1m0s
[18:37:55.659] Received PubSub notification, asking Buildbucket for the build status
[18:37:55.771] Build 8885563736346961072: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:37:55.771] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1584470273910827",
"created_by": "project:chromium",
"created_ts": "1584463100063744",
"id": "8885563736346961072",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49227d673b49cfdca716c26c31d10b9b50d0b17b\"}}",
"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-32-avx6\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27200, \"got_angle_revision\": \"273f9c7c26d701f4a9953594d15753f8a5d88538\", \"got_dawn_revision\": \"971a6233c2a459eb8f9a5f088c17dfb0cd70ee75\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"49227d673b49cfdca716c26c31d10b9b50d0b17b\", \"got_revision_cp\": \"refs/heads/master@{#750991}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"440fc9959f06c539b09fd2e0d1456971132fd7d1\", \"got_v8_revision\": \"17637854361d09d253942562a41f350a8a073810\", \"got_v8_revision_cp\": \"refs/heads/8.3.12@{#1}\", \"got_webrtc_revision\": \"95e01a220bc7eb13c2c644373e6e5a02557faa58\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30809}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49227d673b49cfdca716c26c31d10b9b50d0b17b\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_26ee0c713798d591dc066c3b18aba10c428b81e49e5d430ca5b1f8f50ef6f654_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_91dc5ce0f7d9a4ba8efbdbb6360d947a001f2754e92adddaf9400582bbdcce50_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-32-avx6\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1584463104133803",
"status": "COMPLETED",
"status_changed_ts": "1584470274186115",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27200",
"builder:Deterministic Linux",
"buildset:commit/git/49227d673b49cfdca716c26c31d10b9b50d0b17b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49227d673b49cfdca716c26c31d10b9b50d0b17b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050993798578027248",
"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/8885563736346961072/+/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:4b022dc6b051c110",
"user_agent:luci-scheduler"
],
"updated_ts": "1584470274191316",
"url": "https://ci.chromium.org/b/8885563736346961072",
"utcnow_ts": "1584470275764118"
}
}
[18:37:55.771] Invocation finished in 1h59m37.219395148s with status SUCCEEDED