[16:21:48.806] New invocation is queued and will start shortly
[16:21:50.001] Starting the invocation (attempt 1)
[16:21:50.097] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:21:50.099] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:21:50.099] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029251564494728256",
"parameters_json": "{\"builder_name\":\"Mac deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bcc7b142090a67e7fa298744e37c531a191fd1bf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac deterministic",
"scheduler_invocation_id:9029251564494728256",
"scheduler_job_id:chromium/Mac deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/bcc7b142090a67e7fa298744e37c531a191fd1bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bcc7b142090a67e7fa298744e37c531a191fd1bf",
"gitiles_ref:refs/heads/master"
]
}
[16:21:51.436] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605198110259850",
"id": "8863821502295822224",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bcc7b142090a67e7fa298744e37c531a191fd1bf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605198111236070",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/42166",
"builder:Mac deterministic",
"buildset:commit/git/bcc7b142090a67e7fa298744e37c531a191fd1bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bcc7b142090a67e7fa298744e37c531a191fd1bf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029251564494728256",
"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/8863821502295822224/+/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": "1605198111236229",
"url": "https://ci.chromium.org/b/8863821502295822224",
"utcnow_ts": "1605198111415126"
}
}
[16:21:51.436] Task URL: https://ci.chromium.org/b/8863821502295822224
[16:21:51.436] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:2:0) after 1m0s
[16:21:54.817] Received PubSub notification, asking Buildbucket for the build status
[16:21:55.058] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:51.489] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:2:0)
[16:22:51.489] Timer tick, asking Buildbucket for the build status
[16:22:51.610] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:51.610] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:4:0) after 1m0s
[16:23:51.664] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:4:0)
[16:23:51.664] Timer tick, asking Buildbucket for the build status
[16:23:51.782] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:51.782] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:5:0) after 1m0s
[16:24:51.810] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:5:0)
[16:24:51.810] Timer tick, asking Buildbucket for the build status
[16:24:52.763] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:52.763] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:6:0) after 1m0s
[16:25:52.793] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:6:0)
[16:25:52.793] Timer tick, asking Buildbucket for the build status
[16:25:52.919] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:52.919] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:7:0) after 1m0s
[16:26:52.975] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:7:0)
[16:26:52.975] Timer tick, asking Buildbucket for the build status
[16:26:53.074] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:53.074] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:8:0) after 1m0s
[16:27:53.094] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:8:0)
[16:27:53.094] Timer tick, asking Buildbucket for the build status
[16:27:53.231] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:53.231] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:9:0) after 1m0s
[16:28:53.362] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:9:0)
[16:28:53.362] Timer tick, asking Buildbucket for the build status
[16:28:53.609] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:53.609] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:10:0) after 1m0s
[16:29:53.714] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:10:0)
[16:29:53.714] Timer tick, asking Buildbucket for the build status
[16:29:53.830] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:53.830] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:11:0) after 1m0s
[16:30:53.895] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:11:0)
[16:30:53.895] Timer tick, asking Buildbucket for the build status
[16:30:53.968] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:53.968] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:12:0) after 1m0s
[16:31:54.116] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:12:0)
[16:31:54.116] Timer tick, asking Buildbucket for the build status
[16:31:54.630] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:54.630] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:13:0) after 1m0s
[16:32:54.710] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:13:0)
[16:32:54.710] Timer tick, asking Buildbucket for the build status
[16:32:54.933] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:54.933] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:14:0) after 1m0s
[16:33:54.974] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:14:0)
[16:33:54.974] Timer tick, asking Buildbucket for the build status
[16:33:55.319] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:55.319] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:15:0) after 1m0s
[16:34:55.379] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:15:0)
[16:34:55.379] Timer tick, asking Buildbucket for the build status
[16:34:55.498] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:55.498] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:16:0) after 1m0s
[16:35:55.512] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:16:0)
[16:35:55.512] Timer tick, asking Buildbucket for the build status
[16:35:55.583] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:55.583] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:17:0) after 1m0s
[16:36:55.641] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:17:0)
[16:36:55.641] Timer tick, asking Buildbucket for the build status
[16:36:56.443] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:56.443] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:18:0) after 1m0s
[16:37:56.477] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:18:0)
[16:37:56.477] Timer tick, asking Buildbucket for the build status
[16:37:56.557] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:56.557] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:19:0) after 1m0s
[16:38:56.544] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:19:0)
[16:38:56.544] Timer tick, asking Buildbucket for the build status
[16:38:56.621] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:56.621] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:20:0) after 1m0s
[16:39:56.692] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:20:0)
[16:39:56.692] Timer tick, asking Buildbucket for the build status
[16:39:56.753] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:56.753] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:21:0) after 1m0s
[16:40:56.830] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:21:0)
[16:40:56.830] Timer tick, asking Buildbucket for the build status
[16:40:56.991] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:56.991] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:22:0) after 1m0s
[16:41:57.085] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:22:0)
[16:41:57.085] Timer tick, asking Buildbucket for the build status
[16:41:57.311] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:57.311] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:23:0) after 1m0s
[16:42:57.821] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:23:0)
[16:42:57.821] Timer tick, asking Buildbucket for the build status
[16:42:58.038] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:58.038] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:24:0) after 1m0s
[16:43:58.171] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:24:0)
[16:43:58.171] Timer tick, asking Buildbucket for the build status
[16:43:58.247] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:58.247] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:25:0) after 1m0s
[16:44:58.289] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:25:0)
[16:44:58.289] Timer tick, asking Buildbucket for the build status
[16:44:58.614] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:58.614] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:26:0) after 1m0s
[16:45:58.675] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:26:0)
[16:45:58.675] Timer tick, asking Buildbucket for the build status
[16:45:58.744] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:58.744] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:27:0) after 1m0s
[16:47:00.146] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:27:0)
[16:47:00.146] Timer tick, asking Buildbucket for the build status
[16:47:00.524] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:00.525] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:28:0) after 1m0s
[16:48:03.891] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:28:0)
[16:48:03.891] Timer tick, asking Buildbucket for the build status
[16:48:03.995] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:03.995] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:29:0) after 1m0s
[16:49:05.881] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:29:0)
[16:49:05.881] Timer tick, asking Buildbucket for the build status
[16:49:05.973] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:05.973] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:30:0) after 1m0s
[16:50:07.313] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:30:0)
[16:50:07.314] Timer tick, asking Buildbucket for the build status
[16:50:07.402] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:07.404] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:31:0) after 1m0s
[16:51:07.590] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:31:0)
[16:51:07.590] Timer tick, asking Buildbucket for the build status
[16:51:07.897] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:07.897] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:32:0) after 1m0s
[16:52:08.096] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:32:0)
[16:52:08.096] Timer tick, asking Buildbucket for the build status
[16:52:08.306] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:08.306] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:33:0) after 1m0s
[16:53:08.338] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:33:0)
[16:53:08.338] Timer tick, asking Buildbucket for the build status
[16:53:08.419] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:08.419] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:34:0) after 1m0s
[16:54:08.473] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:34:0)
[16:54:08.473] Timer tick, asking Buildbucket for the build status
[16:54:08.591] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:08.591] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:35:0) after 1m0s
[16:55:08.740] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:35:0)
[16:55:08.740] Timer tick, asking Buildbucket for the build status
[16:55:08.826] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:08.826] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:36:0) after 1m0s
[16:56:08.932] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:36:0)
[16:56:08.932] Timer tick, asking Buildbucket for the build status
[16:56:09.186] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:09.186] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:37:0) after 1m0s
[16:57:09.397] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:37:0)
[16:57:09.397] Timer tick, asking Buildbucket for the build status
[16:57:09.525] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:09.525] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:38:0) after 1m0s
[16:58:09.732] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:38:0)
[16:58:09.732] Timer tick, asking Buildbucket for the build status
[16:58:09.855] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:09.855] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:39:0) after 1m0s
[16:59:09.953] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:39:0)
[16:59:09.953] Timer tick, asking Buildbucket for the build status
[16:59:10.656] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:10.656] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:40:0) after 1m0s
[17:00:10.772] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:40:0)
[17:00:10.772] Timer tick, asking Buildbucket for the build status
[17:00:10.997] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:10.997] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:41:0) after 1m0s
[17:01:11.074] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:41:0)
[17:01:11.074] Timer tick, asking Buildbucket for the build status
[17:01:11.215] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:11.215] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:42:0) after 1m0s
[17:02:11.293] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:42:0)
[17:02:11.293] Timer tick, asking Buildbucket for the build status
[17:02:11.695] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:11.695] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:43:0) after 1m0s
[17:03:11.851] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:43:0)
[17:03:11.851] Timer tick, asking Buildbucket for the build status
[17:03:11.998] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:11.998] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:44:0) after 1m0s
[17:04:12.008] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:44:0)
[17:04:12.008] Timer tick, asking Buildbucket for the build status
[17:04:12.136] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:12.136] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:45:0) after 1m0s
[17:05:12.397] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:45:0)
[17:05:12.397] Timer tick, asking Buildbucket for the build status
[17:05:12.810] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:12.810] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:46:0) after 1m0s
[17:06:12.956] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:46:0)
[17:06:12.956] Timer tick, asking Buildbucket for the build status
[17:06:13.253] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:13.253] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:47:0) after 1m0s
[17:07:13.322] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:47:0)
[17:07:13.322] Timer tick, asking Buildbucket for the build status
[17:07:13.743] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:13.743] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:48:0) after 1m0s
[17:08:13.797] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:48:0)
[17:08:13.797] Timer tick, asking Buildbucket for the build status
[17:08:13.998] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:13.998] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:49:0) after 1m0s
[17:09:14.092] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:49:0)
[17:09:14.092] Timer tick, asking Buildbucket for the build status
[17:09:14.157] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:14.158] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:50:0) after 1m0s
[17:10:14.183] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:50:0)
[17:10:14.183] Timer tick, asking Buildbucket for the build status
[17:10:14.346] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:14.346] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:51:0) after 1m0s
[17:11:14.432] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:51:0)
[17:11:14.432] Timer tick, asking Buildbucket for the build status
[17:11:14.834] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:14.834] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:52:0) after 1m0s
[17:12:14.926] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:52:0)
[17:12:14.926] Timer tick, asking Buildbucket for the build status
[17:12:15.065] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:15.065] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:53:0) after 1m0s
[17:13:15.105] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:53:0)
[17:13:15.105] Timer tick, asking Buildbucket for the build status
[17:13:15.162] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:15.162] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:54:0) after 1m0s
[17:14:15.229] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:54:0)
[17:14:15.229] Timer tick, asking Buildbucket for the build status
[17:14:15.295] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:15.295] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:55:0) after 1m0s
[17:15:15.412] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:55:0)
[17:15:15.412] Timer tick, asking Buildbucket for the build status
[17:15:15.491] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:15.491] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:56:0) after 1m0s
[17:16:15.555] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:56:0)
[17:16:15.555] Timer tick, asking Buildbucket for the build status
[17:16:15.694] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:15.694] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:57:0) after 1m0s
[17:17:15.712] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:57:0)
[17:17:15.712] Timer tick, asking Buildbucket for the build status
[17:17:15.825] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:15.825] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:58:0) after 1m0s
[17:18:15.829] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:58:0)
[17:18:15.829] Timer tick, asking Buildbucket for the build status
[17:18:15.905] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:15.905] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:59:0) after 1m0s
[17:19:15.989] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:59:0)
[17:19:15.989] Timer tick, asking Buildbucket for the build status
[17:19:16.065] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:16.065] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:60:0) after 1m0s
[17:20:16.108] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:60:0)
[17:20:16.108] Timer tick, asking Buildbucket for the build status
[17:20:16.294] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:16.294] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:61:0) after 1m0s
[17:21:16.327] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:61:0)
[17:21:16.327] Timer tick, asking Buildbucket for the build status
[17:21:16.401] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:16.401] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:62:0) after 1m0s
[17:22:16.444] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:62:0)
[17:22:16.444] Timer tick, asking Buildbucket for the build status
[17:22:16.713] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:16.713] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:63:0) after 1m0s
[17:23:16.773] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:63:0)
[17:23:16.773] Timer tick, asking Buildbucket for the build status
[17:23:17.005] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:17.005] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:64:0) after 1m0s
[17:24:17.088] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:64:0)
[17:24:17.088] Timer tick, asking Buildbucket for the build status
[17:24:17.238] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:17.238] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:65:0) after 1m0s
[17:25:17.306] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:65:0)
[17:25:17.306] Timer tick, asking Buildbucket for the build status
[17:25:17.582] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:17.582] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:66:0) after 1m0s
[17:26:17.653] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:66:0)
[17:26:17.653] Timer tick, asking Buildbucket for the build status
[17:26:18.073] Build 8863821502295822224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:18.073] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9029251564494728256:67:0) after 1m0s
[17:26:30.902] Received PubSub notification, asking Buildbucket for the build status
[17:26:31.001] Build 8863821502295822224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:26:31.001] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605201988312367",
"created_by": "project:chromium",
"created_ts": "1605198110259850",
"id": "8863821502295822224",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bcc7b142090a67e7fa298744e37c531a191fd1bf\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/opt/s/w/ir/cache\", \"temp_dir\": \"/opt/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build204-m9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Mac deterministic\", \"buildnumber\": 42166, \"clang_revision\": \"llvmorg-12-init-11060-g118c3f3c-1\", \"got_angle_revision\": \"62c10c170bb33f1ad6c9eb13d0cbdf13f95fb27e\", \"got_dawn_revision\": \"2089adc62a671e5c06f8dfae19c942506ef2872f\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"bcc7b142090a67e7fa298744e37c531a191fd1bf\", \"got_revision_cp\": \"refs/heads/master@{#826791}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4804ac8724ff42f0750def99a17ff929cff92d7f\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"40e2a6830ac5f07b03dafefb014492612f4fb650\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32595}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bcc7b142090a67e7fa298744e37c531a191fd1bf\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Mac deterministic\"], \"caches\": [\"builder_7b52a3a1245e897041cdcf338a3870df21540919220c864c03da3b37f2e3c589_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build204-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.15\", \"Mac-10.15.7\", \"Mac-10.15.7-19H2\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.16\"], \"server_version\": [\"5626-39642e9\"], \"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": "1605198113758821",
"status": "COMPLETED",
"status_changed_ts": "1605201988951809",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/42166",
"builder:Mac deterministic",
"buildset:commit/git/bcc7b142090a67e7fa298744e37c531a191fd1bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bcc7b142090a67e7fa298744e37c531a191fd1bf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029251564494728256",
"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/8863821502295822224/+/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:4fd614eded490510",
"user_agent:luci-scheduler"
],
"updated_ts": "1605201989004865",
"url": "https://ci.chromium.org/b/8863821502295822224",
"utcnow_ts": "1605201990985507"
}
}
[17:26:31.001] Invocation finished in 1h4m42.223184674s with status SUCCEEDED