[15:02:36.521] New invocation is queued and will start shortly
[15:02:37.642] Starting the invocation (attempt 1)
[15:02:37.686] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:02:37.687] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:02:37.687] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9036232514028364912",
"parameters_json": "{\"builder_name\":\"Mac deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f735b9b1735eb9efad5e9feb2212b563cf821809\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac deterministic",
"scheduler_invocation_id:9036232514028364912",
"scheduler_job_id:chromium/Mac deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/f735b9b1735eb9efad5e9feb2212b563cf821809",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f735b9b1735eb9efad5e9feb2212b563cf821809",
"gitiles_ref:refs/heads/master"
]
}
[15:02:38.865] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1598540557789469",
"id": "8870802452033996752",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f735b9b1735eb9efad5e9feb2212b563cf821809\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598540558616174",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/40421",
"builder:Mac deterministic",
"buildset:commit/git/f735b9b1735eb9efad5e9feb2212b563cf821809",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f735b9b1735eb9efad5e9feb2212b563cf821809",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036232514028364912",
"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/8870802452033996752/+/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": "1598540558616336",
"url": "https://ci.chromium.org/b/8870802452033996752",
"utcnow_ts": "1598540558854999"
}
}
[15:02:38.865] Task URL: https://ci.chromium.org/b/8870802452033996752
[15:02:38.865] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:2:0) after 1m0s
[15:02:42.224] Received PubSub notification, asking Buildbucket for the build status
[15:02:42.344] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:38.888] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:2:0)
[15:03:38.888] Timer tick, asking Buildbucket for the build status
[15:03:39.058] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:39.058] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:4:0) after 1m0s
[15:04:39.082] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:4:0)
[15:04:39.082] Timer tick, asking Buildbucket for the build status
[15:04:39.196] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:39.196] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:5:0) after 1m0s
[15:05:39.191] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:5:0)
[15:05:39.191] Timer tick, asking Buildbucket for the build status
[15:05:39.392] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:39.392] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:6:0) after 1m0s
[15:06:39.404] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:6:0)
[15:06:39.404] Timer tick, asking Buildbucket for the build status
[15:06:39.564] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:39.564] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:7:0) after 1m0s
[15:07:39.603] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:7:0)
[15:07:39.603] Timer tick, asking Buildbucket for the build status
[15:07:39.721] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:39.721] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:8:0) after 1m0s
[15:08:39.708] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:8:0)
[15:08:39.708] Timer tick, asking Buildbucket for the build status
[15:08:40.049] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:40.049] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:9:0) after 1m0s
[15:09:40.341] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:9:0)
[15:09:40.341] Timer tick, asking Buildbucket for the build status
[15:09:40.459] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:40.459] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:10:0) after 1m0s
[15:10:40.824] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:10:0)
[15:10:40.824] Timer tick, asking Buildbucket for the build status
[15:10:40.928] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:40.928] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:11:0) after 1m0s
[15:11:41.184] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:11:0)
[15:11:41.184] Timer tick, asking Buildbucket for the build status
[15:11:41.252] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:41.252] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:12:0) after 1m0s
[15:12:41.341] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:12:0)
[15:12:41.341] Timer tick, asking Buildbucket for the build status
[15:12:41.774] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:41.774] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:13:0) after 1m0s
[15:13:41.915] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:13:0)
[15:13:41.915] Timer tick, asking Buildbucket for the build status
[15:13:42.187] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:42.187] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:14:0) after 1m0s
[15:14:42.358] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:14:0)
[15:14:42.358] Timer tick, asking Buildbucket for the build status
[15:14:42.461] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:42.462] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:15:0) after 1m0s
[15:15:42.735] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:15:0)
[15:15:42.735] Timer tick, asking Buildbucket for the build status
[15:15:42.841] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:42.841] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:16:0) after 1m0s
[15:16:43.035] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:16:0)
[15:16:43.035] Timer tick, asking Buildbucket for the build status
[15:16:43.288] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:43.288] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:17:0) after 1m0s
[15:17:43.351] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:17:0)
[15:17:43.351] Timer tick, asking Buildbucket for the build status
[15:17:43.525] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:43.525] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:18:0) after 1m0s
[15:18:43.600] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:18:0)
[15:18:43.600] Timer tick, asking Buildbucket for the build status
[15:18:43.669] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:43.669] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:19:0) after 1m0s
[15:19:43.693] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:19:0)
[15:19:43.693] Timer tick, asking Buildbucket for the build status
[15:19:43.749] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:43.749] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:20:0) after 1m0s
[15:20:43.891] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:20:0)
[15:20:43.891] Timer tick, asking Buildbucket for the build status
[15:20:44.194] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:44.194] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:21:0) after 1m0s
[15:21:44.317] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:21:0)
[15:21:44.317] Timer tick, asking Buildbucket for the build status
[15:21:44.384] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:44.384] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:22:0) after 1m0s
[15:22:44.409] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:22:0)
[15:22:44.409] Timer tick, asking Buildbucket for the build status
[15:22:44.497] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:44.497] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:23:0) after 1m0s
[15:23:44.561] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:23:0)
[15:23:44.561] Timer tick, asking Buildbucket for the build status
[15:23:44.620] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:44.620] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:24:0) after 1m0s
[15:24:44.685] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:24:0)
[15:24:44.685] Timer tick, asking Buildbucket for the build status
[15:24:44.891] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:44.891] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:25:0) after 1m0s
[15:25:44.919] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:25:0)
[15:25:44.919] Timer tick, asking Buildbucket for the build status
[15:25:44.994] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:44.994] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:26:0) after 1m0s
[15:26:45.021] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:26:0)
[15:26:45.021] Timer tick, asking Buildbucket for the build status
[15:26:45.087] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:45.087] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:27:0) after 1m0s
[15:27:45.118] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:27:0)
[15:27:45.118] Timer tick, asking Buildbucket for the build status
[15:27:45.237] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:45.237] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:28:0) after 1m0s
[15:28:45.264] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:28:0)
[15:28:45.264] Timer tick, asking Buildbucket for the build status
[15:28:45.447] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:45.447] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:29:0) after 1m0s
[15:29:45.485] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:29:0)
[15:29:45.485] Timer tick, asking Buildbucket for the build status
[15:29:46.088] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:46.088] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:30:0) after 1m0s
[15:30:46.179] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:30:0)
[15:30:46.179] Timer tick, asking Buildbucket for the build status
[15:30:46.247] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:46.247] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:31:0) after 1m0s
[15:31:46.255] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:31:0)
[15:31:46.255] Timer tick, asking Buildbucket for the build status
[15:31:47.793] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:47.793] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:32:0) after 1m0s
[15:32:47.876] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:32:0)
[15:32:47.876] Timer tick, asking Buildbucket for the build status
[15:32:48.058] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:48.058] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:33:0) after 1m0s
[15:33:48.179] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:33:0)
[15:33:48.179] Timer tick, asking Buildbucket for the build status
[15:33:48.288] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:48.288] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:34:0) after 1m0s
[15:34:48.312] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:34:0)
[15:34:48.312] Timer tick, asking Buildbucket for the build status
[15:34:48.554] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:48.554] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:35:0) after 1m0s
[15:35:48.578] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:35:0)
[15:35:48.578] Timer tick, asking Buildbucket for the build status
[15:35:49.003] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:49.003] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:36:0) after 1m0s
[15:36:49.002] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:36:0)
[15:36:49.002] Timer tick, asking Buildbucket for the build status
[15:36:49.327] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:49.327] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:37:0) after 1m0s
[15:37:49.343] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:37:0)
[15:37:49.343] Timer tick, asking Buildbucket for the build status
[15:37:49.518] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:49.518] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:38:0) after 1m0s
[15:38:49.524] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:38:0)
[15:38:49.524] Timer tick, asking Buildbucket for the build status
[15:38:49.646] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:49.646] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:39:0) after 1m0s
[15:39:50.794] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:39:0)
[15:39:50.794] Timer tick, asking Buildbucket for the build status
[15:39:51.061] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:51.061] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:40:0) after 1m0s
[15:40:51.701] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:40:0)
[15:40:51.701] Timer tick, asking Buildbucket for the build status
[15:40:51.840] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:51.840] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:41:0) after 1m0s
[15:41:52.405] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:41:0)
[15:41:52.405] Timer tick, asking Buildbucket for the build status
[15:41:52.782] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:52.782] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:42:0) after 1m0s
[15:42:53.291] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:42:0)
[15:42:53.291] Timer tick, asking Buildbucket for the build status
[15:42:53.622] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:53.622] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:43:0) after 1m0s
[15:43:53.702] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:43:0)
[15:43:53.702] Timer tick, asking Buildbucket for the build status
[15:43:53.884] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:53.884] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:44:0) after 1m0s
[15:44:54.010] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:44:0)
[15:44:54.010] Timer tick, asking Buildbucket for the build status
[15:44:54.089] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:54.089] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:45:0) after 1m0s
[15:45:54.346] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:45:0)
[15:45:54.346] Timer tick, asking Buildbucket for the build status
[15:45:54.439] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:54.439] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:46:0) after 1m0s
[15:46:54.981] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:46:0)
[15:46:54.981] Timer tick, asking Buildbucket for the build status
[15:46:55.372] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:55.372] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:47:0) after 1m0s
[15:47:55.419] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:47:0)
[15:47:55.419] Timer tick, asking Buildbucket for the build status
[15:47:55.623] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:55.623] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:48:0) after 1m0s
[15:48:55.697] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:48:0)
[15:48:55.697] Timer tick, asking Buildbucket for the build status
[15:48:55.839] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:55.839] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:49:0) after 1m0s
[15:49:55.856] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:49:0)
[15:49:55.856] Timer tick, asking Buildbucket for the build status
[15:49:56.082] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:56.082] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:50:0) after 1m0s
[15:50:56.127] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:50:0)
[15:50:56.127] Timer tick, asking Buildbucket for the build status
[15:50:56.214] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:56.214] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:51:0) after 1m0s
[15:51:56.246] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:51:0)
[15:51:56.246] Timer tick, asking Buildbucket for the build status
[15:51:56.312] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:56.312] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:52:0) after 1m0s
[15:52:56.414] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:52:0)
[15:52:56.414] Timer tick, asking Buildbucket for the build status
[15:52:56.912] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:56.912] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:53:0) after 1m0s
[15:53:57.065] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:53:0)
[15:53:57.065] Timer tick, asking Buildbucket for the build status
[15:53:57.167] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:57.167] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:54:0) after 1m0s
[15:54:57.261] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:54:0)
[15:54:57.261] Timer tick, asking Buildbucket for the build status
[15:54:57.335] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:57.335] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:55:0) after 1m0s
[15:55:57.514] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:55:0)
[15:55:57.514] Timer tick, asking Buildbucket for the build status
[15:55:57.570] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:57.570] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:56:0) after 1m0s
[15:56:57.811] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:56:0)
[15:56:57.811] Timer tick, asking Buildbucket for the build status
[15:56:57.925] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:57.925] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:57:0) after 1m0s
[15:57:58.041] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:57:0)
[15:57:58.041] Timer tick, asking Buildbucket for the build status
[15:57:58.245] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:58.245] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:58:0) after 1m0s
[15:58:58.491] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:58:0)
[15:58:58.491] Timer tick, asking Buildbucket for the build status
[15:58:58.805] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:58.805] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:59:0) after 1m0s
[15:59:58.910] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:59:0)
[15:59:58.910] Timer tick, asking Buildbucket for the build status
[15:59:59.188] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:59.188] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:60:0) after 1m0s
[16:00:59.284] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:60:0)
[16:00:59.284] Timer tick, asking Buildbucket for the build status
[16:00:59.867] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:59.867] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:61:0) after 1m0s
[16:02:00.238] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:61:0)
[16:02:00.238] Timer tick, asking Buildbucket for the build status
[16:02:00.668] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:00.668] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:62:0) after 1m0s
[16:03:01.015] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:62:0)
[16:03:01.015] Timer tick, asking Buildbucket for the build status
[16:03:03.458] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:03.458] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:63:0) after 1m0s
[16:04:03.866] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:63:0)
[16:04:03.866] Timer tick, asking Buildbucket for the build status
[16:04:03.953] Build 8870802452033996752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:03.953] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9036232514028364912:64:0) after 1m0s
[16:04:33.934] Received PubSub notification, asking Buildbucket for the build status
[16:04:34.312] Build 8870802452033996752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:04:34.312] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1598544272803362",
"created_by": "project:chromium",
"created_ts": "1598540557789469",
"id": "8870802452033996752",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f735b9b1735eb9efad5e9feb2212b563cf821809\"}}",
"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\": 40421, \"clang_revision\": \"llvmorg-12-init-3492-ga1caa302-1\", \"got_angle_revision\": \"282596778418f1b35c809cdba3dceb778f1d4a26\", \"got_dawn_revision\": \"900bd341a3c6fc71dfbaeac8adb45b1da0de53d0\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"f735b9b1735eb9efad5e9feb2212b563cf821809\", \"got_revision_cp\": \"refs/heads/master@{#802224}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"1f48854dae26a2d129ae771e671a2172acb2da86\", \"got_v8_revision\": \"128fd453fb11daac9c03b0de83d4d40ca5a87cf2\", \"got_v8_revision_cp\": \"refs/heads/8.7.27@{#1}\", \"got_webrtc_revision\": \"a8327d441549f2abca3c4ac22b5d71c123e3d431\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32005}\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f735b9b1735eb9efad5e9feb2212b563cf821809\"}, \"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": "1598540561316481",
"status": "COMPLETED",
"status_changed_ts": "1598544273304405",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/40421",
"builder:Mac deterministic",
"buildset:commit/git/f735b9b1735eb9efad5e9feb2212b563cf821809",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f735b9b1735eb9efad5e9feb2212b563cf821809",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036232514028364912",
"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/8870802452033996752/+/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:4e4942bc3c893510",
"user_agent:luci-scheduler"
],
"updated_ts": "1598544273318735",
"url": "https://ci.chromium.org/b/8870802452033996752",
"utcnow_ts": "1598544274251117"
}
}
[16:04:34.312] Invocation finished in 1h1m57.808527151s with status SUCCEEDED