[02:11:24.284] New invocation is queued and will start shortly
[02:11:25.414] Starting the invocation (attempt 1)
[02:11:25.450] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:11:25.450] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:11:25.450] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032204170503167120",
"parameters_json": "{\"builder_name\":\"Mac deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"242577f773c26498985d063f4ec3dca9e87cbf20\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac deterministic",
"scheduler_invocation_id:9032204170503167120",
"scheduler_job_id:chromium/Mac deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/242577f773c26498985d063f4ec3dca9e87cbf20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/242577f773c26498985d063f4ec3dca9e87cbf20",
"gitiles_ref:refs/heads/master"
]
}
[02:11:26.309] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602382285577910",
"id": "8866774108477065472",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"242577f773c26498985d063f4ec3dca9e87cbf20\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602382286176231",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/41430",
"builder:Mac deterministic",
"buildset:commit/git/242577f773c26498985d063f4ec3dca9e87cbf20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/242577f773c26498985d063f4ec3dca9e87cbf20",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032204170503167120",
"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/8866774108477065472/+/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": "1602382286176342",
"url": "https://ci.chromium.org/b/8866774108477065472",
"utcnow_ts": "1602382286300869"
}
}
[02:11:26.309] Task URL: https://ci.chromium.org/b/8866774108477065472
[02:11:26.309] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:2:0) after 1m0s
[02:11:33.234] Received PubSub notification, asking Buildbucket for the build status
[02:11:33.317] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:26.364] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:2:0)
[02:12:26.364] Timer tick, asking Buildbucket for the build status
[02:12:26.510] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:26.510] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:4:0) after 1m0s
[02:13:26.558] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:4:0)
[02:13:26.558] Timer tick, asking Buildbucket for the build status
[02:13:26.674] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:26.674] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:5:0) after 1m0s
[02:14:26.772] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:5:0)
[02:14:26.772] Timer tick, asking Buildbucket for the build status
[02:14:26.885] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:26.885] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:6:0) after 1m0s
[02:15:26.876] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:6:0)
[02:15:26.876] Timer tick, asking Buildbucket for the build status
[02:15:26.973] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:26.973] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:7:0) after 1m0s
[02:16:26.974] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:7:0)
[02:16:26.974] Timer tick, asking Buildbucket for the build status
[02:16:27.073] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:27.073] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:8:0) after 1m0s
[02:17:27.098] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:8:0)
[02:17:27.098] Timer tick, asking Buildbucket for the build status
[02:17:27.205] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:27.205] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:9:0) after 1m0s
[02:18:27.227] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:9:0)
[02:18:27.227] Timer tick, asking Buildbucket for the build status
[02:18:27.429] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:27.429] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:10:0) after 1m0s
[02:19:27.525] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:10:0)
[02:19:27.525] Timer tick, asking Buildbucket for the build status
[02:19:27.675] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:27.675] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:11:0) after 1m0s
[02:20:27.783] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:11:0)
[02:20:27.783] Timer tick, asking Buildbucket for the build status
[02:20:27.871] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:27.871] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:12:0) after 1m0s
[02:21:27.926] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:12:0)
[02:21:27.926] Timer tick, asking Buildbucket for the build status
[02:21:28.033] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:28.033] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:13:0) after 1m0s
[02:22:28.051] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:13:0)
[02:22:28.051] Timer tick, asking Buildbucket for the build status
[02:22:28.106] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:28.106] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:14:0) after 1m0s
[02:23:28.264] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:14:0)
[02:23:28.264] Timer tick, asking Buildbucket for the build status
[02:23:28.346] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:28.346] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:15:0) after 1m0s
[02:24:28.441] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:15:0)
[02:24:28.441] Timer tick, asking Buildbucket for the build status
[02:24:28.643] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:28.643] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:16:0) after 1m0s
[02:25:28.696] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:16:0)
[02:25:28.696] Timer tick, asking Buildbucket for the build status
[02:25:28.899] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:28.899] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:17:0) after 1m0s
[02:26:28.971] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:17:0)
[02:26:28.971] Timer tick, asking Buildbucket for the build status
[02:26:29.057] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:29.057] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:18:0) after 1m0s
[02:27:29.132] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:18:0)
[02:27:29.132] Timer tick, asking Buildbucket for the build status
[02:27:29.289] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:29.289] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:19:0) after 1m0s
[02:28:29.323] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:19:0)
[02:28:29.323] Timer tick, asking Buildbucket for the build status
[02:28:29.531] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:29.531] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:20:0) after 1m0s
[02:29:29.589] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:20:0)
[02:29:29.589] Timer tick, asking Buildbucket for the build status
[02:29:29.669] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:29.669] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:21:0) after 1m0s
[02:30:29.694] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:21:0)
[02:30:29.694] Timer tick, asking Buildbucket for the build status
[02:30:29.758] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:29.758] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:22:0) after 1m0s
[02:31:29.878] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:22:0)
[02:31:29.878] Timer tick, asking Buildbucket for the build status
[02:31:30.107] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:30.107] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:23:0) after 1m0s
[02:32:30.141] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:23:0)
[02:32:30.141] Timer tick, asking Buildbucket for the build status
[02:32:30.212] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:30.212] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:24:0) after 1m0s
[02:33:30.248] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:24:0)
[02:33:30.248] Timer tick, asking Buildbucket for the build status
[02:33:30.344] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:30.344] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:25:0) after 1m0s
[02:34:30.492] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:25:0)
[02:34:30.492] Timer tick, asking Buildbucket for the build status
[02:34:30.782] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:30.782] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:26:0) after 1m0s
[02:35:30.944] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:26:0)
[02:35:30.944] Timer tick, asking Buildbucket for the build status
[02:35:31.013] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:31.013] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:27:0) after 1m0s
[02:36:31.135] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:27:0)
[02:36:31.135] Timer tick, asking Buildbucket for the build status
[02:36:31.411] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:31.411] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:28:0) after 1m0s
[02:37:31.437] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:28:0)
[02:37:31.437] Timer tick, asking Buildbucket for the build status
[02:37:31.498] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:31.498] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:29:0) after 1m0s
[02:38:31.597] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:29:0)
[02:38:31.597] Timer tick, asking Buildbucket for the build status
[02:38:32.192] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:32.192] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:30:0) after 1m0s
[02:39:32.415] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:30:0)
[02:39:32.415] Timer tick, asking Buildbucket for the build status
[02:39:32.511] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:32.511] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:31:0) after 1m0s
[02:40:32.529] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:31:0)
[02:40:32.529] Timer tick, asking Buildbucket for the build status
[02:40:32.616] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:32.616] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:32:0) after 1m0s
[02:41:32.648] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:32:0)
[02:41:32.648] Timer tick, asking Buildbucket for the build status
[02:41:32.742] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:32.742] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:33:0) after 1m0s
[02:42:32.831] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:33:0)
[02:42:32.831] Timer tick, asking Buildbucket for the build status
[02:42:32.904] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:32.904] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:34:0) after 1m0s
[02:43:33.109] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:34:0)
[02:43:33.109] Timer tick, asking Buildbucket for the build status
[02:43:33.165] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:33.165] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:35:0) after 1m0s
[02:44:33.337] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:35:0)
[02:44:33.337] Timer tick, asking Buildbucket for the build status
[02:44:33.524] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:33.524] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:36:0) after 1m0s
[02:45:33.594] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:36:0)
[02:45:33.594] Timer tick, asking Buildbucket for the build status
[02:45:33.791] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:33.791] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:37:0) after 1m0s
[02:46:33.784] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:37:0)
[02:46:33.784] Timer tick, asking Buildbucket for the build status
[02:46:33.885] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:33.885] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:38:0) after 1m0s
[02:47:33.914] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:38:0)
[02:47:33.914] Timer tick, asking Buildbucket for the build status
[02:47:33.968] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:33.968] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:39:0) after 1m0s
[02:48:34.037] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:39:0)
[02:48:34.037] Timer tick, asking Buildbucket for the build status
[02:48:34.100] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:34.100] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:40:0) after 1m0s
[02:49:34.133] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:40:0)
[02:49:34.134] Timer tick, asking Buildbucket for the build status
[02:49:34.220] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:34.220] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:41:0) after 1m0s
[02:50:34.243] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:41:0)
[02:50:34.243] Timer tick, asking Buildbucket for the build status
[02:50:34.306] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:34.306] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:42:0) after 1m0s
[02:51:34.358] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:42:0)
[02:51:34.358] Timer tick, asking Buildbucket for the build status
[02:51:34.452] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:34.452] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:43:0) after 1m0s
[02:52:34.529] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:43:0)
[02:52:34.529] Timer tick, asking Buildbucket for the build status
[02:52:34.597] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:34.597] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:44:0) after 1m0s
[02:53:34.619] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:44:0)
[02:53:34.619] Timer tick, asking Buildbucket for the build status
[02:53:34.693] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:34.693] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:45:0) after 1m0s
[02:54:34.709] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:45:0)
[02:54:34.709] Timer tick, asking Buildbucket for the build status
[02:54:34.771] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:34.771] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:46:0) after 1m0s
[02:55:34.828] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:46:0)
[02:55:34.828] Timer tick, asking Buildbucket for the build status
[02:55:34.882] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:34.882] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:47:0) after 1m0s
[02:56:34.902] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:47:0)
[02:56:34.902] Timer tick, asking Buildbucket for the build status
[02:56:35.002] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:35.002] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:48:0) after 1m0s
[02:57:35.072] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:48:0)
[02:57:35.072] Timer tick, asking Buildbucket for the build status
[02:57:35.140] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:35.140] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:49:0) after 1m0s
[02:58:35.159] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:49:0)
[02:58:35.159] Timer tick, asking Buildbucket for the build status
[02:58:35.226] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:35.226] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:50:0) after 1m0s
[02:59:35.331] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:50:0)
[02:59:35.331] Timer tick, asking Buildbucket for the build status
[02:59:35.407] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:35.407] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:51:0) after 1m0s
[03:00:35.495] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:51:0)
[03:00:35.495] Timer tick, asking Buildbucket for the build status
[03:00:35.558] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:35.559] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:52:0) after 1m0s
[03:01:35.729] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:52:0)
[03:01:35.729] Timer tick, asking Buildbucket for the build status
[03:01:35.831] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:35.831] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:53:0) after 1m0s
[03:02:35.852] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:53:0)
[03:02:35.852] Timer tick, asking Buildbucket for the build status
[03:02:35.978] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:35.978] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:54:0) after 1m0s
[03:03:36.052] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:54:0)
[03:03:36.052] Timer tick, asking Buildbucket for the build status
[03:03:36.224] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:36.224] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:55:0) after 1m0s
[03:04:36.252] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:55:0)
[03:04:36.252] Timer tick, asking Buildbucket for the build status
[03:04:36.373] Build 8866774108477065472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:36.373] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032204170503167120:56:0) after 1m0s
[03:05:33.618] Received PubSub notification, asking Buildbucket for the build status
[03:05:33.677] Build 8866774108477065472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:05:33.677] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602385532733698",
"created_by": "project:chromium",
"created_ts": "1602382285577910",
"id": "8866774108477065472",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"242577f773c26498985d063f4ec3dca9e87cbf20\"}}",
"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\": \"/opt/s/w/ir/cache\", \"temp_dir\": \"/opt/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\": 41430, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-2\", \"got_angle_revision\": \"3345e5fdc5c4360c770ddad6260dd10f80dbd762\", \"got_dawn_revision\": \"1c25198384e7ecfebbd3ac84203d3b1d46a0e228\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"242577f773c26498985d063f4ec3dca9e87cbf20\", \"got_revision_cp\": \"refs/heads/master@{#815979}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"cca740fc48dfffbe24a5ee0bfe23ed1ec2b21580\", \"got_v8_revision\": \"07b0b1dcde4a99294b8028d83f4ea244885cc091\", \"got_v8_revision_cp\": \"refs/heads/8.8.62@{#1}\", \"got_webrtc_revision\": \"3326535126e435f1ba647885ce43a8f0f3d317eb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32375}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"242577f773c26498985d063f4ec3dca9e87cbf20\"}, \"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.15\", \"Mac-10.15.7\", \"Mac-10.15.7-19H2\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.16\"], \"server_version\": [\"5570-fa4adf0\"], \"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": "1602382291261044",
"status": "COMPLETED",
"status_changed_ts": "1602385533227790",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/41430",
"builder:Mac deterministic",
"buildset:commit/git/242577f773c26498985d063f4ec3dca9e87cbf20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/242577f773c26498985d063f4ec3dca9e87cbf20",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032204170503167120",
"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/8866774108477065472/+/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:4f2e3ed64664bc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1602385533231567",
"url": "https://ci.chromium.org/b/8866774108477065472",
"utcnow_ts": "1602385533663943"
}
}
[03:05:33.677] Invocation finished in 54m9.416012876s with status SUCCEEDED