[02:01:14.462] New invocation is queued and will start shortly
[02:01:15.545] Starting the invocation (attempt 1)
[02:01:15.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:01:15.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:01:15.581] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034107346234804464",
"parameters_json": "{\"builder_name\":\"Mac deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac deterministic",
"scheduler_invocation_id:9034107346234804464",
"scheduler_job_id:chromium/Mac deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357",
"gitiles_ref:refs/heads/master"
]
}
[02:01:16.168] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1600567275689642",
"id": "8868677284285626000",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600567276046952",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/40977",
"builder:Mac deterministic",
"buildset:commit/git/4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034107346234804464",
"scheduler_job_id:chromium/Mac deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8868677284285626000/+/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": "1600567276047057",
"url": "https://ci.chromium.org/b/8868677284285626000",
"utcnow_ts": "1600567276160927"
}
}
[02:01:16.168] Task URL: https://ci.chromium.org/b/8868677284285626000
[02:01:16.168] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:2:0) after 1m0s
[02:01:19.777] Received PubSub notification, asking Buildbucket for the build status
[02:01:19.842] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:16.214] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:2:0)
[02:02:16.214] Timer tick, asking Buildbucket for the build status
[02:02:16.556] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:16.556] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:4:0) after 1m0s
[02:03:16.538] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:4:0)
[02:03:16.538] Timer tick, asking Buildbucket for the build status
[02:03:16.640] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:16.640] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:5:0) after 1m0s
[02:04:16.685] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:5:0)
[02:04:16.685] Timer tick, asking Buildbucket for the build status
[02:04:16.790] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:16.790] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:6:0) after 1m0s
[02:05:16.864] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:6:0)
[02:05:16.864] Timer tick, asking Buildbucket for the build status
[02:05:16.986] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:16.986] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:7:0) after 1m0s
[02:06:17.099] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:7:0)
[02:06:17.099] Timer tick, asking Buildbucket for the build status
[02:06:17.181] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:17.182] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:8:0) after 1m0s
[02:07:17.211] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:8:0)
[02:07:17.211] Timer tick, asking Buildbucket for the build status
[02:07:17.428] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:17.428] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:9:0) after 1m0s
[02:08:17.501] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:9:0)
[02:08:17.501] Timer tick, asking Buildbucket for the build status
[02:08:17.740] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:17.740] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:10:0) after 1m0s
[02:09:17.834] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:10:0)
[02:09:17.834] Timer tick, asking Buildbucket for the build status
[02:09:18.029] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:18.029] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:11:0) after 1m0s
[02:10:18.060] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:11:0)
[02:10:18.060] Timer tick, asking Buildbucket for the build status
[02:10:18.240] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:18.240] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:12:0) after 1m0s
[02:11:18.273] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:12:0)
[02:11:18.273] Timer tick, asking Buildbucket for the build status
[02:11:18.503] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:18.503] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:13:0) after 1m0s
[02:12:18.553] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:13:0)
[02:12:18.553] Timer tick, asking Buildbucket for the build status
[02:12:18.611] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:18.611] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:14:0) after 1m0s
[02:13:18.647] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:14:0)
[02:13:18.647] Timer tick, asking Buildbucket for the build status
[02:13:18.779] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:18.779] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:15:0) after 1m0s
[02:14:18.797] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:15:0)
[02:14:18.797] Timer tick, asking Buildbucket for the build status
[02:14:18.896] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:18.896] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:16:0) after 1m0s
[02:15:18.920] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:16:0)
[02:15:18.920] Timer tick, asking Buildbucket for the build status
[02:15:19.039] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:19.039] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:17:0) after 1m0s
[02:16:19.108] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:17:0)
[02:16:19.108] Timer tick, asking Buildbucket for the build status
[02:16:19.244] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:19.244] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:18:0) after 1m0s
[02:17:19.238] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:18:0)
[02:17:19.238] Timer tick, asking Buildbucket for the build status
[02:17:19.375] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:19.375] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:19:0) after 1m0s
[02:18:19.398] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:19:0)
[02:18:19.398] Timer tick, asking Buildbucket for the build status
[02:18:19.461] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:19.461] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:20:0) after 1m0s
[02:19:19.484] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:20:0)
[02:19:19.484] Timer tick, asking Buildbucket for the build status
[02:19:19.568] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:19.568] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:21:0) after 1m0s
[02:20:20.695] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:21:0)
[02:20:20.696] Timer tick, asking Buildbucket for the build status
[02:20:20.771] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:20.771] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:22:0) after 1m0s
[02:21:20.873] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:22:0)
[02:21:20.873] Timer tick, asking Buildbucket for the build status
[02:21:21.274] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:21.274] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:23:0) after 1m0s
[02:22:21.383] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:23:0)
[02:22:21.383] Timer tick, asking Buildbucket for the build status
[02:22:21.594] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:21.594] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:24:0) after 1m0s
[02:23:21.843] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:24:0)
[02:23:21.843] Timer tick, asking Buildbucket for the build status
[02:23:22.390] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:22.390] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:25:0) after 1m0s
[02:24:22.818] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:25:0)
[02:24:22.818] Timer tick, asking Buildbucket for the build status
[02:24:24.078] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:24.078] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:26:0) after 1m0s
[02:25:24.281] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:26:0)
[02:25:24.281] Timer tick, asking Buildbucket for the build status
[02:25:24.638] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:24.638] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:27:0) after 1m0s
[02:26:24.672] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:27:0)
[02:26:24.672] Timer tick, asking Buildbucket for the build status
[02:26:24.827] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:24.827] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:28:0) after 1m0s
[02:27:24.909] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:28:0)
[02:27:24.909] Timer tick, asking Buildbucket for the build status
[02:27:25.057] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:25.057] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:29:0) after 1m0s
[02:28:25.138] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:29:0)
[02:28:25.138] Timer tick, asking Buildbucket for the build status
[02:28:25.239] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:25.239] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:30:0) after 1m0s
[02:29:25.269] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:30:0)
[02:29:25.269] Timer tick, asking Buildbucket for the build status
[02:29:25.364] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:25.364] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:31:0) after 1m0s
[02:30:25.552] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:31:0)
[02:30:25.552] Timer tick, asking Buildbucket for the build status
[02:30:25.686] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:25.686] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:32:0) after 1m0s
[02:31:25.782] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:32:0)
[02:31:25.782] Timer tick, asking Buildbucket for the build status
[02:31:25.900] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:25.900] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:33:0) after 1m0s
[02:32:26.014] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:33:0)
[02:32:26.014] Timer tick, asking Buildbucket for the build status
[02:32:26.078] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:26.078] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:34:0) after 1m0s
[02:33:26.111] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:34:0)
[02:33:26.111] Timer tick, asking Buildbucket for the build status
[02:33:26.197] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:26.197] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:35:0) after 1m0s
[02:34:26.356] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:35:0)
[02:34:26.357] Timer tick, asking Buildbucket for the build status
[02:34:26.436] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:26.437] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:36:0) after 1m0s
[02:35:26.680] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:36:0)
[02:35:26.680] Timer tick, asking Buildbucket for the build status
[02:35:26.829] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:26.829] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:37:0) after 1m0s
[02:36:27.062] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:37:0)
[02:36:27.062] Timer tick, asking Buildbucket for the build status
[02:36:27.169] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:27.169] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:38:0) after 1m0s
[02:37:27.292] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:38:0)
[02:37:27.292] Timer tick, asking Buildbucket for the build status
[02:37:27.422] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:27.422] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:39:0) after 1m0s
[02:38:27.421] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:39:0)
[02:38:27.421] Timer tick, asking Buildbucket for the build status
[02:38:27.695] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:27.695] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:40:0) after 1m0s
[02:39:27.718] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:40:0)
[02:39:27.718] Timer tick, asking Buildbucket for the build status
[02:39:27.921] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:27.921] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:41:0) after 1m0s
[02:40:27.975] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:41:0)
[02:40:27.975] Timer tick, asking Buildbucket for the build status
[02:40:28.195] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:28.195] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:42:0) after 1m0s
[02:41:28.481] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:42:0)
[02:41:28.481] Timer tick, asking Buildbucket for the build status
[02:41:28.618] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:28.618] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:43:0) after 1m0s
[02:42:28.747] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:43:0)
[02:42:28.747] Timer tick, asking Buildbucket for the build status
[02:42:28.821] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:28.821] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:44:0) after 1m0s
[02:43:28.980] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:44:0)
[02:43:28.980] Timer tick, asking Buildbucket for the build status
[02:43:29.043] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:29.043] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:45:0) after 1m0s
[02:44:29.134] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:45:0)
[02:44:29.134] Timer tick, asking Buildbucket for the build status
[02:44:29.389] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:29.389] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:46:0) after 1m0s
[02:45:29.470] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:46:0)
[02:45:29.470] Timer tick, asking Buildbucket for the build status
[02:45:29.538] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:29.538] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:47:0) after 1m0s
[02:46:29.558] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:47:0)
[02:46:29.558] Timer tick, asking Buildbucket for the build status
[02:46:29.791] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:29.791] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:48:0) after 1m0s
[02:47:32.267] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:48:0)
[02:47:32.268] Timer tick, asking Buildbucket for the build status
[02:47:32.524] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:32.524] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:49:0) after 1m0s
[02:48:32.549] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:49:0)
[02:48:32.549] Timer tick, asking Buildbucket for the build status
[02:48:32.634] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:32.634] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:50:0) after 1m0s
[02:49:32.671] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:50:0)
[02:49:32.671] Timer tick, asking Buildbucket for the build status
[02:49:32.752] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:32.752] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:51:0) after 1m0s
[02:50:32.822] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:51:0)
[02:50:32.822] Timer tick, asking Buildbucket for the build status
[02:50:32.887] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:32.887] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:52:0) after 1m0s
[02:51:32.923] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:52:0)
[02:51:32.923] Timer tick, asking Buildbucket for the build status
[02:51:33.026] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:33.026] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:53:0) after 1m0s
[02:52:33.026] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:53:0)
[02:52:33.026] Timer tick, asking Buildbucket for the build status
[02:52:33.404] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:33.404] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:54:0) after 1m0s
[02:53:33.446] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:54:0)
[02:53:33.446] Timer tick, asking Buildbucket for the build status
[02:53:33.654] Build 8868677284285626000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:33.654] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9034107346234804464:55:0) after 1m0s
[02:53:43.796] Received PubSub notification, asking Buildbucket for the build status
[02:53:43.858] Build 8868677284285626000: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:53:43.858] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1600570423102977",
"created_by": "project:chromium",
"created_ts": "1600567275689642",
"id": "8868677284285626000",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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\": \"build204-m9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Mac deterministic\", \"buildnumber\": 40977, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-2\", \"got_angle_revision\": \"76e90947a8e421308dff9d00c4955717c6667f12\", \"got_dawn_revision\": \"dcd37fa4f47663d1a68c1c7fb10738b6ea0e0a4c\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357\", \"got_revision_cp\": \"refs/heads/master@{#808723}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"fe878dedd5addbedab4033c0cb6b19bbbe04f8e4\", \"got_v8_revision\": \"80dc1e8055bca07e8da6162bace5ee87f23faccf\", \"got_v8_revision_cp\": \"refs/heads/8.7.142@{#1}\", \"got_webrtc_revision\": \"14dbf82961c32ae9133bb672c88e146942062ada\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32143}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Mac deterministic\"], \"caches\": [\"builder_7b52a3a1245e897041cdcf338a3870df21540919220c864c03da3b37f2e3c589_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build204-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\", \"Mac-10.13.6-17G66\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"5531-8ab19d9\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1600567279109783",
"status": "COMPLETED",
"status_changed_ts": "1600570423500492",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/40977",
"builder:Mac deterministic",
"buildset:commit/git/4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4495c2ebf501fb8ebc731a3cfb9c4c0733c2a357",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034107346234804464",
"scheduler_job_id:chromium/Mac deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8868677284285626000/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4ec20ffac8891910",
"user_agent:luci-scheduler"
],
"updated_ts": "1600570423506847",
"url": "https://ci.chromium.org/b/8868677284285626000",
"utcnow_ts": "1600570423851108"
}
}
[02:53:43.858] Invocation finished in 52m29.411389996s with status SUCCEEDED