[20:24:54.103] New invocation is queued and will start shortly
[20:24:55.343] Starting the invocation (attempt 1)
[20:24:55.382] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:24:55.382] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:24:55.382] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9035034476539522992",
"parameters_json": "{\"builder_name\":\"Mac deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"03e2bfa91ffd813f48caa37cb2f6b3575a14e827\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac deterministic",
"scheduler_invocation_id:9035034476539522992",
"scheduler_job_id:chromium/Mac deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/03e2bfa91ffd813f48caa37cb2f6b3575a14e827",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03e2bfa91ffd813f48caa37cb2f6b3575a14e827",
"gitiles_ref:refs/heads/master"
]
}
[20:24:56.384] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1599683095477123",
"id": "8869604414434868960",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03e2bfa91ffd813f48caa37cb2f6b3575a14e827\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599683096071669",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/40736",
"builder:Mac deterministic",
"buildset:commit/git/03e2bfa91ffd813f48caa37cb2f6b3575a14e827",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03e2bfa91ffd813f48caa37cb2f6b3575a14e827",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035034476539522992",
"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/8869604414434868960/+/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": "1599683096071809",
"url": "https://ci.chromium.org/b/8869604414434868960",
"utcnow_ts": "1599683096372065"
}
}
[20:24:56.384] Task URL: https://ci.chromium.org/b/8869604414434868960
[20:24:56.385] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:2:0) after 1m0s
[20:25:51.649] Received PubSub notification, asking Buildbucket for the build status
[20:25:51.844] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:56.507] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:2:0)
[20:25:56.507] Timer tick, asking Buildbucket for the build status
[20:25:56.690] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:56.690] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:4:0) after 1m0s
[20:26:56.753] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:4:0)
[20:26:56.753] Timer tick, asking Buildbucket for the build status
[20:26:56.920] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:56.920] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:5:0) after 1m0s
[20:27:56.948] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:5:0)
[20:27:56.948] Timer tick, asking Buildbucket for the build status
[20:27:57.147] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:57.147] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:6:0) after 1m0s
[20:28:57.175] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:6:0)
[20:28:57.175] Timer tick, asking Buildbucket for the build status
[20:28:57.609] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:57.609] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:7:0) after 1m0s
[20:29:57.698] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:7:0)
[20:29:57.698] Timer tick, asking Buildbucket for the build status
[20:29:57.810] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:57.810] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:8:0) after 1m0s
[20:30:57.860] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:8:0)
[20:30:57.860] Timer tick, asking Buildbucket for the build status
[20:30:58.733] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:58.733] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:9:0) after 1m0s
[20:31:58.913] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:9:0)
[20:31:58.913] Timer tick, asking Buildbucket for the build status
[20:31:59.288] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:59.288] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:10:0) after 1m0s
[20:32:59.334] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:10:0)
[20:32:59.334] Timer tick, asking Buildbucket for the build status
[20:32:59.574] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:59.574] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:11:0) after 1m0s
[20:33:59.628] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:11:0)
[20:33:59.628] Timer tick, asking Buildbucket for the build status
[20:33:59.707] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:59.707] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:12:0) after 1m0s
[20:34:59.773] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:12:0)
[20:34:59.773] Timer tick, asking Buildbucket for the build status
[20:35:00.428] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:00.428] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:13:0) after 1m0s
[20:36:01.832] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:13:0)
[20:36:01.832] Timer tick, asking Buildbucket for the build status
[20:36:02.298] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:02.298] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:14:0) after 1m0s
[20:37:02.352] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:14:0)
[20:37:02.352] Timer tick, asking Buildbucket for the build status
[20:37:02.526] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:02.526] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:15:0) after 1m0s
[20:38:02.616] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:15:0)
[20:38:02.616] Timer tick, asking Buildbucket for the build status
[20:38:02.817] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:02.817] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:16:0) after 1m0s
[20:39:02.843] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:16:0)
[20:39:02.843] Timer tick, asking Buildbucket for the build status
[20:39:02.919] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:02.919] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:17:0) after 1m0s
[20:40:03.016] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:17:0)
[20:40:03.016] Timer tick, asking Buildbucket for the build status
[20:40:03.555] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:03.555] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:18:0) after 1m0s
[20:41:03.692] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:18:0)
[20:41:03.692] Timer tick, asking Buildbucket for the build status
[20:41:04.202] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:04.202] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:19:0) after 1m0s
[20:42:04.341] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:19:0)
[20:42:04.341] Timer tick, asking Buildbucket for the build status
[20:42:04.481] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:04.481] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:20:0) after 1m0s
[20:43:04.648] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:20:0)
[20:43:04.648] Timer tick, asking Buildbucket for the build status
[20:43:04.813] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:04.813] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:21:0) after 1m0s
[20:44:04.851] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:21:0)
[20:44:04.851] Timer tick, asking Buildbucket for the build status
[20:44:04.924] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:04.924] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:22:0) after 1m0s
[20:45:05.002] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:22:0)
[20:45:05.002] Timer tick, asking Buildbucket for the build status
[20:45:05.122] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:05.122] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:23:0) after 1m0s
[20:46:05.211] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:23:0)
[20:46:05.211] Timer tick, asking Buildbucket for the build status
[20:46:05.291] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:05.291] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:24:0) after 1m0s
[20:47:05.268] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:24:0)
[20:47:05.268] Timer tick, asking Buildbucket for the build status
[20:47:05.509] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:05.509] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:25:0) after 1m0s
[20:48:05.581] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:25:0)
[20:48:05.581] Timer tick, asking Buildbucket for the build status
[20:48:05.651] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:05.651] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:26:0) after 1m0s
[20:49:05.703] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:26:0)
[20:49:05.703] Timer tick, asking Buildbucket for the build status
[20:49:05.872] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:05.872] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:27:0) after 1m0s
[20:50:05.959] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:27:0)
[20:50:05.959] Timer tick, asking Buildbucket for the build status
[20:50:06.522] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:06.522] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:28:0) after 1m0s
[20:51:06.550] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:28:0)
[20:51:06.550] Timer tick, asking Buildbucket for the build status
[20:51:06.610] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:06.610] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:29:0) after 1m0s
[20:52:06.640] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:29:0)
[20:52:06.640] Timer tick, asking Buildbucket for the build status
[20:52:06.806] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:06.806] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:30:0) after 1m0s
[20:53:06.829] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:30:0)
[20:53:06.829] Timer tick, asking Buildbucket for the build status
[20:53:07.082] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:07.082] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:31:0) after 1m0s
[20:54:07.111] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:31:0)
[20:54:07.111] Timer tick, asking Buildbucket for the build status
[20:54:07.322] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:07.322] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:32:0) after 1m0s
[20:55:07.545] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:32:0)
[20:55:07.545] Timer tick, asking Buildbucket for the build status
[20:55:07.812] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:07.812] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:33:0) after 1m0s
[20:56:07.847] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:33:0)
[20:56:07.847] Timer tick, asking Buildbucket for the build status
[20:56:07.943] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:07.943] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:34:0) after 1m0s
[20:57:08.098] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:34:0)
[20:57:08.098] Timer tick, asking Buildbucket for the build status
[20:57:08.398] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:08.398] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:35:0) after 1m0s
[20:58:08.687] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:35:0)
[20:58:08.687] Timer tick, asking Buildbucket for the build status
[20:58:08.845] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:08.845] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:36:0) after 1m0s
[20:59:09.002] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:36:0)
[20:59:09.002] Timer tick, asking Buildbucket for the build status
[20:59:09.195] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:09.195] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:37:0) after 1m0s
[21:00:09.418] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:37:0)
[21:00:09.418] Timer tick, asking Buildbucket for the build status
[21:00:09.636] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:09.636] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:38:0) after 1m0s
[21:01:09.642] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:38:0)
[21:01:09.642] Timer tick, asking Buildbucket for the build status
[21:01:09.998] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:09.998] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:39:0) after 1m0s
[21:02:10.145] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:39:0)
[21:02:10.145] Timer tick, asking Buildbucket for the build status
[21:02:10.694] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:10.694] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:40:0) after 1m0s
[21:03:10.746] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:40:0)
[21:03:10.746] Timer tick, asking Buildbucket for the build status
[21:03:11.007] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:11.007] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:41:0) after 1m0s
[21:04:11.050] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:41:0)
[21:04:11.050] Timer tick, asking Buildbucket for the build status
[21:04:11.152] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:11.152] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:42:0) after 1m0s
[21:05:11.269] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:42:0)
[21:05:11.269] Timer tick, asking Buildbucket for the build status
[21:05:11.458] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:11.458] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:43:0) after 1m0s
[21:06:11.526] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:43:0)
[21:06:11.526] Timer tick, asking Buildbucket for the build status
[21:06:11.737] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:11.737] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:44:0) after 1m0s
[21:07:11.786] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:44:0)
[21:07:11.786] Timer tick, asking Buildbucket for the build status
[21:07:12.029] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:12.029] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:45:0) after 1m0s
[21:08:12.203] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:45:0)
[21:08:12.203] Timer tick, asking Buildbucket for the build status
[21:08:12.277] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:12.277] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:46:0) after 1m0s
[21:09:12.430] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:46:0)
[21:09:12.430] Timer tick, asking Buildbucket for the build status
[21:09:12.511] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:12.511] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:47:0) after 1m0s
[21:10:12.551] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:47:0)
[21:10:12.551] Timer tick, asking Buildbucket for the build status
[21:10:12.878] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:12.878] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:48:0) after 1m0s
[21:11:12.985] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:48:0)
[21:11:12.985] Timer tick, asking Buildbucket for the build status
[21:11:13.058] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:13.058] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:49:0) after 1m0s
[21:12:13.121] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:49:0)
[21:12:13.121] Timer tick, asking Buildbucket for the build status
[21:12:13.247] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:13.247] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:50:0) after 1m0s
[21:13:13.333] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:50:0)
[21:13:13.333] Timer tick, asking Buildbucket for the build status
[21:13:13.435] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:13.435] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:51:0) after 1m0s
[21:14:13.472] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:51:0)
[21:14:13.472] Timer tick, asking Buildbucket for the build status
[21:14:13.539] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:13.539] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:52:0) after 1m0s
[21:15:13.624] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:52:0)
[21:15:13.624] Timer tick, asking Buildbucket for the build status
[21:15:13.944] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:13.944] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:53:0) after 1m0s
[21:16:14.025] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:53:0)
[21:16:14.025] Timer tick, asking Buildbucket for the build status
[21:16:14.195] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:14.195] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:54:0) after 1m0s
[21:17:14.217] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:54:0)
[21:17:14.217] Timer tick, asking Buildbucket for the build status
[21:17:14.884] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:14.884] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:55:0) after 1m0s
[21:18:14.976] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:55:0)
[21:18:14.976] Timer tick, asking Buildbucket for the build status
[21:18:15.109] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:15.109] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:56:0) after 1m0s
[21:19:15.312] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:56:0)
[21:19:15.312] Timer tick, asking Buildbucket for the build status
[21:19:15.418] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:15.418] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:57:0) after 1m0s
[21:20:15.565] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:57:0)
[21:20:15.565] Timer tick, asking Buildbucket for the build status
[21:20:15.821] Build 8869604414434868960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:15.821] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9035034476539522992:58:0) after 1m0s
[21:20:16.314] Received PubSub notification, asking Buildbucket for the build status
[21:20:16.513] Build 8869604414434868960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:20:16.513] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1599686415320065",
"created_by": "project:chromium",
"created_ts": "1599683095477123",
"id": "8869604414434868960",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03e2bfa91ffd813f48caa37cb2f6b3575a14e827\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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\": 40736, \"clang_revision\": \"llvmorg-12-init-5035-gd0abc757-1\", \"got_angle_revision\": \"48df087f8a86cb68c494875c04d08b7f32171986\", \"got_dawn_revision\": \"0a1061da0c7fc759a4ca06edf5b4e2f36915b15f\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"03e2bfa91ffd813f48caa37cb2f6b3575a14e827\", \"got_revision_cp\": \"refs/heads/master@{#805465}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"ce08265ba5b7b6d3a090137d4e06b7e5af1f7fba\", \"got_v8_revision\": \"bb4817544d7ce327fc432a8229efa213952ca979\", \"got_v8_revision_cp\": \"refs/heads/8.7.76@{#1}\", \"got_webrtc_revision\": \"9e9c8b7155d49c2f38b82fe9c9707181c57073c9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32051}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03e2bfa91ffd813f48caa37cb2f6b3575a14e827\"}, \"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\": [\"5513-ee65082\"], \"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": "1599683150740625",
"status": "COMPLETED",
"status_changed_ts": "1599686415944439",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/40736",
"builder:Mac deterministic",
"buildset:commit/git/03e2bfa91ffd813f48caa37cb2f6b3575a14e827",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03e2bfa91ffd813f48caa37cb2f6b3575a14e827",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035034476539522992",
"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/8869604414434868960/+/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:4e8d5c7791cc9110",
"user_agent:luci-scheduler"
],
"updated_ts": "1599686415952754",
"url": "https://ci.chromium.org/b/8869604414434868960",
"utcnow_ts": "1599686416501338"
}
}
[21:20:16.513] Invocation finished in 55m22.425942156s with status SUCCEEDED