[19:43:09.009] New invocation is queued and will start shortly
[19:43:11.516] Starting the invocation (attempt 1)
[19:43:11.576] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:43:11.576] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:43:11.576] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9036849042650785456",
"parameters_json": "{\"builder_name\":\"Mac deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"53c5a84a039c176ac1bc9991b66bdee206d69879\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac deterministic",
"scheduler_invocation_id:9036849042650785456",
"scheduler_job_id:chromium/Mac deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/53c5a84a039c176ac1bc9991b66bdee206d69879",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53c5a84a039c176ac1bc9991b66bdee206d69879",
"gitiles_ref:refs/heads/master"
]
}
[19:43:12.645] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1597952591712853",
"id": "8871418979151389584",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53c5a84a039c176ac1bc9991b66bdee206d69879\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1597952592287334",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/40259",
"builder:Mac deterministic",
"buildset:commit/git/53c5a84a039c176ac1bc9991b66bdee206d69879",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53c5a84a039c176ac1bc9991b66bdee206d69879",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036849042650785456",
"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/8871418979151389584/+/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": "1597952592287540",
"url": "https://ci.chromium.org/b/8871418979151389584",
"utcnow_ts": "1597952592631716"
}
}
[19:43:12.645] Task URL: https://ci.chromium.org/b/8871418979151389584
[19:43:12.645] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:2:0) after 1m0s
[19:43:15.018] Received PubSub notification, asking Buildbucket for the build status
[19:43:15.301] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:12.683] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:2:0)
[19:44:12.683] Timer tick, asking Buildbucket for the build status
[19:44:12.874] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:12.874] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:4:0) after 1m0s
[19:45:12.905] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:4:0)
[19:45:12.905] Timer tick, asking Buildbucket for the build status
[19:45:13.022] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:13.022] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:5:0) after 1m0s
[19:46:13.109] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:5:0)
[19:46:13.109] Timer tick, asking Buildbucket for the build status
[19:46:13.245] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:13.245] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:6:0) after 1m0s
[19:47:13.280] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:6:0)
[19:47:13.280] Timer tick, asking Buildbucket for the build status
[19:47:13.528] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:13.528] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:7:0) after 1m0s
[19:48:13.576] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:7:0)
[19:48:13.576] Timer tick, asking Buildbucket for the build status
[19:48:13.760] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:13.760] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:8:0) after 1m0s
[19:49:13.858] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:8:0)
[19:49:13.858] Timer tick, asking Buildbucket for the build status
[19:49:14.046] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:14.046] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:9:0) after 1m0s
[19:50:14.074] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:9:0)
[19:50:14.074] Timer tick, asking Buildbucket for the build status
[19:50:14.435] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:14.435] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:10:0) after 1m0s
[19:51:14.460] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:10:0)
[19:51:14.461] Timer tick, asking Buildbucket for the build status
[19:51:14.571] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:14.571] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:11:0) after 1m0s
[19:52:14.655] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:11:0)
[19:52:14.655] Timer tick, asking Buildbucket for the build status
[19:52:14.843] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:14.843] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:12:0) after 1m0s
[19:53:14.869] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:12:0)
[19:53:14.869] Timer tick, asking Buildbucket for the build status
[19:53:15.100] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:15.100] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:13:0) after 1m0s
[19:54:15.149] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:13:0)
[19:54:15.149] Timer tick, asking Buildbucket for the build status
[19:54:15.237] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:15.237] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:14:0) after 1m0s
[19:55:15.359] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:14:0)
[19:55:15.359] Timer tick, asking Buildbucket for the build status
[19:55:15.523] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:15.523] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:15:0) after 1m0s
[19:56:15.549] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:15:0)
[19:56:15.549] Timer tick, asking Buildbucket for the build status
[19:56:15.673] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:15.673] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:16:0) after 1m0s
[19:57:15.696] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:16:0)
[19:57:15.696] Timer tick, asking Buildbucket for the build status
[19:57:15.843] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:15.843] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:17:0) after 1m0s
[19:58:15.849] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:17:0)
[19:58:15.849] Timer tick, asking Buildbucket for the build status
[19:58:16.270] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:16.270] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:18:0) after 1m0s
[19:59:16.314] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:18:0)
[19:59:16.314] Timer tick, asking Buildbucket for the build status
[19:59:18.893] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:18.893] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:19:0) after 1m0s
[20:00:18.925] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:19:0)
[20:00:18.925] Timer tick, asking Buildbucket for the build status
[20:00:19.259] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:19.259] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:20:0) after 1m0s
[20:01:19.283] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:20:0)
[20:01:19.283] Timer tick, asking Buildbucket for the build status
[20:01:19.379] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:19.379] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:21:0) after 1m0s
[20:02:19.411] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:21:0)
[20:02:19.411] Timer tick, asking Buildbucket for the build status
[20:02:19.521] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:19.521] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:22:0) after 1m0s
[20:03:19.499] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:22:0)
[20:03:19.499] Timer tick, asking Buildbucket for the build status
[20:03:19.852] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:19.852] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:23:0) after 1m0s
[20:04:19.879] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:23:0)
[20:04:19.879] Timer tick, asking Buildbucket for the build status
[20:04:20.068] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:20.068] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:24:0) after 1m0s
[20:05:20.087] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:24:0)
[20:05:20.087] Timer tick, asking Buildbucket for the build status
[20:05:20.169] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:20.169] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:25:0) after 1m0s
[20:06:20.216] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:25:0)
[20:06:20.216] Timer tick, asking Buildbucket for the build status
[20:06:20.339] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:20.339] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:26:0) after 1m0s
[20:07:20.381] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:26:0)
[20:07:20.381] Timer tick, asking Buildbucket for the build status
[20:07:20.475] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:20.475] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:27:0) after 1m0s
[20:08:20.522] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:27:0)
[20:08:20.522] Timer tick, asking Buildbucket for the build status
[20:08:20.678] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:20.678] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:28:0) after 1m0s
[20:09:20.731] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:28:0)
[20:09:20.731] Timer tick, asking Buildbucket for the build status
[20:09:21.216] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:21.216] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:29:0) after 1m0s
[20:10:21.379] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:29:0)
[20:10:21.379] Timer tick, asking Buildbucket for the build status
[20:10:21.634] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:21.634] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:30:0) after 1m0s
[20:11:21.740] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:30:0)
[20:11:21.740] Timer tick, asking Buildbucket for the build status
[20:11:21.844] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:21.844] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:31:0) after 1m0s
[20:12:21.931] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:31:0)
[20:12:21.931] Timer tick, asking Buildbucket for the build status
[20:12:22.219] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:22.219] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:32:0) after 1m0s
[20:13:22.293] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:32:0)
[20:13:22.293] Timer tick, asking Buildbucket for the build status
[20:13:22.539] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:22.539] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:33:0) after 1m0s
[20:14:22.577] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:33:0)
[20:14:22.577] Timer tick, asking Buildbucket for the build status
[20:14:22.794] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:22.794] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:34:0) after 1m0s
[20:15:22.855] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:34:0)
[20:15:22.855] Timer tick, asking Buildbucket for the build status
[20:15:23.090] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:23.090] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:35:0) after 1m0s
[20:16:23.115] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:35:0)
[20:16:23.115] Timer tick, asking Buildbucket for the build status
[20:16:23.377] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:23.377] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:36:0) after 1m0s
[20:17:23.349] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:36:0)
[20:17:23.349] Timer tick, asking Buildbucket for the build status
[20:17:23.699] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:23.699] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:37:0) after 1m0s
[20:18:23.750] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:37:0)
[20:18:23.750] Timer tick, asking Buildbucket for the build status
[20:18:23.932] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:23.932] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:38:0) after 1m0s
[20:19:23.924] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:38:0)
[20:19:23.924] Timer tick, asking Buildbucket for the build status
[20:19:24.566] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:24.566] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:39:0) after 1m0s
[20:20:24.622] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:39:0)
[20:20:24.622] Timer tick, asking Buildbucket for the build status
[20:20:24.785] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:24.785] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:40:0) after 1m0s
[20:21:24.808] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:40:0)
[20:21:24.808] Timer tick, asking Buildbucket for the build status
[20:21:27.280] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:27.280] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:41:0) after 1m0s
[20:22:27.468] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:41:0)
[20:22:27.468] Timer tick, asking Buildbucket for the build status
[20:22:27.664] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:27.667] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:42:0) after 1m0s
[20:23:27.839] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:42:0)
[20:23:27.839] Timer tick, asking Buildbucket for the build status
[20:23:27.981] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:27.986] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:43:0) after 1m0s
[20:24:28.162] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:43:0)
[20:24:28.162] Timer tick, asking Buildbucket for the build status
[20:24:28.275] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:28.275] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:44:0) after 1m0s
[20:25:28.308] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:44:0)
[20:25:28.308] Timer tick, asking Buildbucket for the build status
[20:25:28.526] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:28.526] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:45:0) after 1m0s
[20:26:28.665] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:45:0)
[20:26:28.665] Timer tick, asking Buildbucket for the build status
[20:26:28.788] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:28.788] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:46:0) after 1m0s
[20:27:28.931] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:46:0)
[20:27:28.931] Timer tick, asking Buildbucket for the build status
[20:27:29.632] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:29.632] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:47:0) after 1m0s
[20:28:29.721] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:47:0)
[20:28:29.721] Timer tick, asking Buildbucket for the build status
[20:28:29.901] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:29.901] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:48:0) after 1m0s
[20:29:30.024] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:48:0)
[20:29:30.024] Timer tick, asking Buildbucket for the build status
[20:29:30.251] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:30.251] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:49:0) after 1m0s
[20:30:30.417] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:49:0)
[20:30:30.417] Timer tick, asking Buildbucket for the build status
[20:30:30.699] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:30.699] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:50:0) after 1m0s
[20:31:30.846] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:50:0)
[20:31:30.846] Timer tick, asking Buildbucket for the build status
[20:31:31.063] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:31.063] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:51:0) after 1m0s
[20:32:31.184] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:51:0)
[20:32:31.184] Timer tick, asking Buildbucket for the build status
[20:32:31.413] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:31.413] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:52:0) after 1m0s
[20:33:31.426] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:52:0)
[20:33:31.426] Timer tick, asking Buildbucket for the build status
[20:33:31.585] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:31.585] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:53:0) after 1m0s
[20:34:31.648] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:53:0)
[20:34:31.648] Timer tick, asking Buildbucket for the build status
[20:34:31.752] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:31.752] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:54:0) after 1m0s
[20:35:31.792] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:54:0)
[20:35:31.792] Timer tick, asking Buildbucket for the build status
[20:35:31.930] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:31.930] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:55:0) after 1m0s
[20:36:32.000] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:55:0)
[20:36:32.000] Timer tick, asking Buildbucket for the build status
[20:36:32.072] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:32.072] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:56:0) after 1m0s
[20:37:32.149] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:56:0)
[20:37:32.149] Timer tick, asking Buildbucket for the build status
[20:37:32.235] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:32.235] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:57:0) after 1m0s
[20:38:32.375] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:57:0)
[20:38:32.375] Timer tick, asking Buildbucket for the build status
[20:38:32.595] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:32.595] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:58:0) after 1m0s
[20:39:32.630] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:58:0)
[20:39:32.630] Timer tick, asking Buildbucket for the build status
[20:39:32.833] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:32.833] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:59:0) after 1m0s
[20:40:32.857] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:59:0)
[20:40:32.857] Timer tick, asking Buildbucket for the build status
[20:40:33.032] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:33.032] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:60:0) after 1m0s
[20:41:33.066] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:60:0)
[20:41:33.066] Timer tick, asking Buildbucket for the build status
[20:41:33.258] Build 8871418979151389584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:33.258] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036849042650785456:61:0) after 1m0s
[20:42:08.888] Received PubSub notification, asking Buildbucket for the build status
[20:42:09.335] Build 8871418979151389584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:42:09.336] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1597956127800217",
"created_by": "project:chromium",
"created_ts": "1597952591712853",
"id": "8871418979151389584",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53c5a84a039c176ac1bc9991b66bdee206d69879\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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\": \"build204-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Mac deterministic\", \"buildnumber\": 40259, \"clang_revision\": \"llvmorg-12-init-3492-ga1caa302-1\", \"got_angle_revision\": \"c060d8d65786a4cfee3e43b70476354f05987c7d\", \"got_dawn_revision\": \"ab4e4feb01ac2e3fc4d202ebf261817b664b69d9\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"53c5a84a039c176ac1bc9991b66bdee206d69879\", \"got_revision_cp\": \"refs/heads/master@{#800273}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"cbfd396756c6530ee31268d88e5e742ba761fc57\", \"got_v8_revision\": \"a64aed2333abf49e494d2a5ce24bbd14fff19f60\", \"got_v8_revision_cp\": \"refs/heads/8.6.395@{#1}\", \"got_webrtc_revision\": \"6a9a910fd2c302ae58305cbd68739e1c5e70011d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31970}\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53c5a84a039c176ac1bc9991b66bdee206d69879\"}, \"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\": [\"5498-3454aa6\"], \"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": "1597952593659775",
"status": "COMPLETED",
"status_changed_ts": "1597956128229466",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/40259",
"builder:Mac deterministic",
"buildset:commit/git/53c5a84a039c176ac1bc9991b66bdee206d69879",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53c5a84a039c176ac1bc9991b66bdee206d69879",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036849042650785456",
"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/8871418979151389584/+/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:4e26371383f97410",
"user_agent:luci-scheduler"
],
"updated_ts": "1597956128284949",
"url": "https://ci.chromium.org/b/8871418979151389584",
"utcnow_ts": "1597956129312889"
}
}
[20:42:09.336] Invocation finished in 59m0.344919595s with status SUCCEEDED