[06:34:21.078] New invocation is queued and will start shortly
[06:34:22.298] Starting the invocation (attempt 1)
[06:34:22.332] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:34:22.333] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:34:22.333] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032731209127926112",
"parameters_json": "{\"builder_name\":\"Mac deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"eee042327bfc4fef4cdeab847b382d3c5b0116e3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac deterministic",
"scheduler_invocation_id:9032731209127926112",
"scheduler_job_id:chromium/Mac deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/eee042327bfc4fef4cdeab847b382d3c5b0116e3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eee042327bfc4fef4cdeab847b382d3c5b0116e3",
"gitiles_ref:refs/heads/master"
]
}
[06:34:23.307] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1601879662417647",
"id": "8867301147059734368",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eee042327bfc4fef4cdeab847b382d3c5b0116e3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1601879663018074",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/41289",
"builder:Mac deterministic",
"buildset:commit/git/eee042327bfc4fef4cdeab847b382d3c5b0116e3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eee042327bfc4fef4cdeab847b382d3c5b0116e3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032731209127926112",
"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/8867301147059734368/+/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": "1601879663018263",
"url": "https://ci.chromium.org/b/8867301147059734368",
"utcnow_ts": "1601879663276793"
}
}
[06:34:23.307] Task URL: https://ci.chromium.org/b/8867301147059734368
[06:34:23.307] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:2:0) after 1m0s
[06:34:27.347] Received PubSub notification, asking Buildbucket for the build status
[06:34:27.568] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:23.328] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:2:0)
[06:35:23.328] Timer tick, asking Buildbucket for the build status
[06:35:23.451] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:23.451] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:4:0) after 1m0s
[06:36:23.528] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:4:0)
[06:36:23.528] Timer tick, asking Buildbucket for the build status
[06:36:23.844] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:23.844] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:5:0) after 1m0s
[06:37:23.984] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:5:0)
[06:37:23.984] Timer tick, asking Buildbucket for the build status
[06:37:24.312] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:24.312] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:6:0) after 1m0s
[06:38:24.333] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:6:0)
[06:38:24.333] Timer tick, asking Buildbucket for the build status
[06:38:24.477] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:24.477] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:7:0) after 1m0s
[06:39:24.899] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:7:0)
[06:39:24.899] Timer tick, asking Buildbucket for the build status
[06:39:25.111] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:25.111] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:8:0) after 1m0s
[06:40:25.207] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:8:0)
[06:40:25.207] Timer tick, asking Buildbucket for the build status
[06:40:25.343] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:25.343] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:9:0) after 1m0s
[06:41:25.372] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:9:0)
[06:41:25.372] Timer tick, asking Buildbucket for the build status
[06:41:25.469] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:25.469] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:10:0) after 1m0s
[06:42:25.574] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:10:0)
[06:42:25.574] Timer tick, asking Buildbucket for the build status
[06:42:25.635] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:25.635] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:11:0) after 1m0s
[06:43:25.759] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:11:0)
[06:43:25.759] Timer tick, asking Buildbucket for the build status
[06:43:26.120] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:26.120] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:12:0) after 1m0s
[06:44:26.305] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:12:0)
[06:44:26.305] Timer tick, asking Buildbucket for the build status
[06:44:26.771] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:26.771] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:13:0) after 1m0s
[06:45:26.931] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:13:0)
[06:45:26.931] Timer tick, asking Buildbucket for the build status
[06:45:27.028] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:27.028] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:14:0) after 1m0s
[06:46:27.126] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:14:0)
[06:46:27.126] Timer tick, asking Buildbucket for the build status
[06:46:27.265] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:27.265] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:15:0) after 1m0s
[06:47:27.527] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:15:0)
[06:47:27.528] Timer tick, asking Buildbucket for the build status
[06:47:27.634] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:27.634] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:16:0) after 1m0s
[06:48:27.720] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:16:0)
[06:48:27.720] Timer tick, asking Buildbucket for the build status
[06:48:29.432] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:29.432] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:17:0) after 1m0s
[06:49:29.471] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:17:0)
[06:49:29.471] Timer tick, asking Buildbucket for the build status
[06:49:29.607] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:29.607] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:18:0) after 1m0s
[06:50:29.625] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:18:0)
[06:50:29.625] Timer tick, asking Buildbucket for the build status
[06:50:29.702] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:29.702] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:19:0) after 1m0s
[06:51:29.772] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:19:0)
[06:51:29.772] Timer tick, asking Buildbucket for the build status
[06:51:29.853] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:29.853] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:20:0) after 1m0s
[06:52:29.908] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:20:0)
[06:52:29.908] Timer tick, asking Buildbucket for the build status
[06:52:30.181] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:30.181] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:21:0) after 1m0s
[06:53:30.182] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:21:0)
[06:53:30.182] Timer tick, asking Buildbucket for the build status
[06:53:30.473] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:30.473] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:22:0) after 1m0s
[06:54:30.514] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:22:0)
[06:54:30.514] Timer tick, asking Buildbucket for the build status
[06:54:30.864] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:30.864] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:23:0) after 1m0s
[06:55:31.269] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:23:0)
[06:55:31.269] Timer tick, asking Buildbucket for the build status
[06:55:31.397] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:31.397] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:24:0) after 1m0s
[06:56:31.611] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:24:0)
[06:56:31.611] Timer tick, asking Buildbucket for the build status
[06:56:31.703] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:31.703] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:25:0) after 1m0s
[06:57:31.765] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:25:0)
[06:57:31.765] Timer tick, asking Buildbucket for the build status
[06:57:31.854] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:31.854] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:26:0) after 1m0s
[06:58:31.873] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:26:0)
[06:58:31.873] Timer tick, asking Buildbucket for the build status
[06:58:32.226] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:32.226] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:27:0) after 1m0s
[06:59:32.299] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:27:0)
[06:59:32.299] Timer tick, asking Buildbucket for the build status
[06:59:32.435] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:32.435] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:28:0) after 1m0s
[07:00:32.553] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:28:0)
[07:00:32.553] Timer tick, asking Buildbucket for the build status
[07:00:33.001] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:33.001] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:29:0) after 1m0s
[07:01:33.042] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:29:0)
[07:01:33.042] Timer tick, asking Buildbucket for the build status
[07:01:33.146] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:33.146] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:30:0) after 1m0s
[07:02:33.219] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:30:0)
[07:02:33.219] Timer tick, asking Buildbucket for the build status
[07:02:34.286] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:34.286] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:31:0) after 1m0s
[07:03:34.310] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:31:0)
[07:03:34.310] Timer tick, asking Buildbucket for the build status
[07:03:34.961] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:34.961] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:32:0) after 1m0s
[07:04:34.985] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:32:0)
[07:04:34.985] Timer tick, asking Buildbucket for the build status
[07:04:35.188] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:35.188] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:33:0) after 1m0s
[07:05:35.209] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:33:0)
[07:05:35.209] Timer tick, asking Buildbucket for the build status
[07:05:36.572] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:36.572] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:34:0) after 1m0s
[07:06:36.623] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:34:0)
[07:06:36.623] Timer tick, asking Buildbucket for the build status
[07:06:36.716] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:36.716] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:35:0) after 1m0s
[07:07:36.691] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:35:0)
[07:07:36.691] Timer tick, asking Buildbucket for the build status
[07:07:36.786] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:36.786] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:36:0) after 1m0s
[07:08:36.805] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:36:0)
[07:08:36.805] Timer tick, asking Buildbucket for the build status
[07:08:37.163] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:37.163] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:37:0) after 1m0s
[07:09:37.198] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:37:0)
[07:09:37.198] Timer tick, asking Buildbucket for the build status
[07:09:37.308] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:37.308] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:38:0) after 1m0s
[07:10:37.365] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:38:0)
[07:10:37.365] Timer tick, asking Buildbucket for the build status
[07:10:37.915] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:37.916] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:39:0) after 1m0s
[07:11:37.933] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:39:0)
[07:11:37.933] Timer tick, asking Buildbucket for the build status
[07:11:38.192] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:38.192] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:40:0) after 1m0s
[07:12:38.226] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:40:0)
[07:12:38.226] Timer tick, asking Buildbucket for the build status
[07:12:38.326] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:38.326] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:41:0) after 1m0s
[07:13:38.348] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:41:0)
[07:13:38.348] Timer tick, asking Buildbucket for the build status
[07:13:38.419] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:38.419] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:42:0) after 1m0s
[07:14:38.440] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:42:0)
[07:14:38.440] Timer tick, asking Buildbucket for the build status
[07:14:39.099] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:39.099] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:43:0) after 1m0s
[07:15:39.118] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:43:0)
[07:15:39.118] Timer tick, asking Buildbucket for the build status
[07:15:39.319] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:39.319] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:44:0) after 1m0s
[07:16:39.339] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:44:0)
[07:16:39.339] Timer tick, asking Buildbucket for the build status
[07:16:40.308] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:40.308] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:45:0) after 1m0s
[07:17:40.328] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:45:0)
[07:17:40.328] Timer tick, asking Buildbucket for the build status
[07:17:41.471] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:41.471] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:46:0) after 1m0s
[07:18:41.561] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:46:0)
[07:18:41.561] Timer tick, asking Buildbucket for the build status
[07:18:41.649] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:41.649] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:47:0) after 1m0s
[07:19:41.778] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:47:0)
[07:19:41.778] Timer tick, asking Buildbucket for the build status
[07:19:43.180] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:43.180] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:48:0) after 1m0s
[07:20:43.270] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:48:0)
[07:20:43.270] Timer tick, asking Buildbucket for the build status
[07:20:45.432] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:45.432] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:49:0) after 1m0s
[07:21:45.442] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:49:0)
[07:21:45.442] Timer tick, asking Buildbucket for the build status
[07:21:46.368] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:46.368] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:50:0) after 1m0s
[07:22:46.389] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:50:0)
[07:22:46.389] Timer tick, asking Buildbucket for the build status
[07:22:46.562] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:46.562] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:51:0) after 1m0s
[07:23:46.586] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:51:0)
[07:23:46.586] Timer tick, asking Buildbucket for the build status
[07:23:47.435] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:47.435] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:52:0) after 1m0s
[07:24:47.467] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:52:0)
[07:24:47.467] Timer tick, asking Buildbucket for the build status
[07:24:48.898] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:48.898] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:53:0) after 1m0s
[07:25:48.953] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:53:0)
[07:25:48.953] Timer tick, asking Buildbucket for the build status
[07:25:50.171] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:50.171] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:54:0) after 1m0s
[07:26:50.194] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:54:0)
[07:26:50.194] Timer tick, asking Buildbucket for the build status
[07:26:50.432] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:50.432] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:55:0) after 1m0s
[07:27:50.453] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:55:0)
[07:27:50.453] Timer tick, asking Buildbucket for the build status
[07:27:51.355] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:51.355] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:56:0) after 1m0s
[07:28:51.346] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:56:0)
[07:28:51.346] Timer tick, asking Buildbucket for the build status
[07:28:51.934] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:51.934] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:57:0) after 1m0s
[07:29:51.973] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:57:0)
[07:29:51.973] Timer tick, asking Buildbucket for the build status
[07:29:52.164] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:52.165] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:58:0) after 1m0s
[07:30:52.186] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:58:0)
[07:30:52.186] Timer tick, asking Buildbucket for the build status
[07:30:54.241] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:54.241] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:59:0) after 1m0s
[07:31:54.257] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:59:0)
[07:31:54.257] Timer tick, asking Buildbucket for the build status
[07:31:54.541] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:54.541] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:60:0) after 1m0s
[07:32:54.596] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:60:0)
[07:32:54.596] Timer tick, asking Buildbucket for the build status
[07:32:54.730] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:54.730] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:61:0) after 1m0s
[07:33:54.787] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:61:0)
[07:33:54.787] Timer tick, asking Buildbucket for the build status
[07:33:54.866] Build 8867301147059734368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:54.866] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9032731209127926112:62:0) after 1m0s
[07:34:21.249] Received PubSub notification, asking Buildbucket for the build status
[07:34:22.542] Build 8867301147059734368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:34:22.542] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1601883260198795",
"created_by": "project:chromium",
"created_ts": "1601879662417647",
"id": "8867301147059734368",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eee042327bfc4fef4cdeab847b382d3c5b0116e3\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build204-m9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Mac deterministic\", \"buildnumber\": 41289, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-2\", \"got_angle_revision\": \"500704812409749c6a6bd0e4fbddf03a60a07cb9\", \"got_dawn_revision\": \"ed3a93f690dedae1a0659d16b260e78cb4229fa1\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"eee042327bfc4fef4cdeab847b382d3c5b0116e3\", \"got_revision_cp\": \"refs/heads/master@{#813628}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"b3c1e71eb1cb55ba78a3f884ab4e68ef1bd396da\", \"got_v8_revision\": \"2d6364fcd947cd451b53e646c5bc5bad0f1b81e8\", \"got_v8_revision_cp\": \"refs/heads/8.8.6@{#1}\", \"got_webrtc_revision\": \"ae5e8ebda79ec70a52874514a6aa52d1ab867a12\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32305}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eee042327bfc4fef4cdeab847b382d3c5b0116e3\"}, \"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\": [\"5564-e41b668\"], \"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": "1601879666420976",
"status": "COMPLETED",
"status_changed_ts": "1601883260598253",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/41289",
"builder:Mac deterministic",
"buildset:commit/git/eee042327bfc4fef4cdeab847b382d3c5b0116e3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eee042327bfc4fef4cdeab847b382d3c5b0116e3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032731209127926112",
"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/8867301147059734368/+/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:4f10496c39e4fd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1601883260619389",
"url": "https://ci.chromium.org/b/8867301147059734368",
"utcnow_ts": "1601883262519219"
}
}
[07:34:22.542] Invocation finished in 1h0m1.480654451s with status SUCCEEDED