[00:22:20.256] New invocation is queued and will start shortly
[00:22:21.610] Starting the invocation (attempt 1)
[00:22:21.653] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:22:21.653] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:22:21.654] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9038009238258465440",
"parameters_json": "{\"builder_name\":\"Mac deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d5c373d14d6897466ff37ab6f884aedabcce0da6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac deterministic",
"scheduler_invocation_id:9038009238258465440",
"scheduler_job_id:chromium/Mac deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/d5c373d14d6897466ff37ab6f884aedabcce0da6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d5c373d14d6897466ff37ab6f884aedabcce0da6",
"gitiles_ref:refs/heads/master"
]
}
[00:22:22.932] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1596846141760497",
"id": "8872579176016460656",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d5c373d14d6897466ff37ab6f884aedabcce0da6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1596846142585173",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/39969",
"builder:Mac deterministic",
"buildset:commit/git/d5c373d14d6897466ff37ab6f884aedabcce0da6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d5c373d14d6897466ff37ab6f884aedabcce0da6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038009238258465440",
"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/8872579176016460656/+/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": "1596846142585335",
"url": "https://ci.chromium.org/b/8872579176016460656",
"utcnow_ts": "1596846142900563"
}
}
[00:22:22.932] Task URL: https://ci.chromium.org/b/8872579176016460656
[00:22:22.932] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:2:0) after 1m0s
[00:22:24.581] Received PubSub notification, asking Buildbucket for the build status
[00:22:24.807] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:22.950] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:2:0)
[00:23:22.950] Timer tick, asking Buildbucket for the build status
[00:23:23.237] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:23.237] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:4:0) after 1m0s
[00:24:23.283] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:4:0)
[00:24:23.283] Timer tick, asking Buildbucket for the build status
[00:24:23.534] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:23.534] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:5:0) after 1m0s
[00:25:23.583] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:5:0)
[00:25:23.584] Timer tick, asking Buildbucket for the build status
[00:25:23.732] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:23.732] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:6:0) after 1m0s
[00:26:23.744] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:6:0)
[00:26:23.744] Timer tick, asking Buildbucket for the build status
[00:26:24.045] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:24.045] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:7:0) after 1m0s
[00:27:24.093] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:7:0)
[00:27:24.093] Timer tick, asking Buildbucket for the build status
[00:27:24.315] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:24.315] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:8:0) after 1m0s
[00:28:24.411] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:8:0)
[00:28:24.411] Timer tick, asking Buildbucket for the build status
[00:28:24.608] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:24.608] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:9:0) after 1m0s
[00:29:24.608] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:9:0)
[00:29:24.608] Timer tick, asking Buildbucket for the build status
[00:29:24.996] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:24.996] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:10:0) after 1m0s
[00:30:25.021] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:10:0)
[00:30:25.021] Timer tick, asking Buildbucket for the build status
[00:30:26.799] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:26.799] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:11:0) after 1m0s
[00:31:26.930] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:11:0)
[00:31:26.930] Timer tick, asking Buildbucket for the build status
[00:31:28.033] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:28.033] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:12:0) after 1m0s
[00:32:28.198] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:12:0)
[00:32:28.198] Timer tick, asking Buildbucket for the build status
[00:32:28.708] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:28.708] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:13:0) after 1m0s
[00:33:28.776] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:13:0)
[00:33:28.776] Timer tick, asking Buildbucket for the build status
[00:33:28.889] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:28.889] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:14:0) after 1m0s
[00:34:29.059] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:14:0)
[00:34:29.059] Timer tick, asking Buildbucket for the build status
[00:34:29.425] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:29.425] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:15:0) after 1m0s
[00:35:29.604] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:15:0)
[00:35:29.604] Timer tick, asking Buildbucket for the build status
[00:35:29.683] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:29.683] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:16:0) after 1m0s
[00:36:29.774] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:16:0)
[00:36:29.774] Timer tick, asking Buildbucket for the build status
[00:36:29.923] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:29.923] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:17:0) after 1m0s
[00:37:29.994] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:17:0)
[00:37:29.994] Timer tick, asking Buildbucket for the build status
[00:37:30.145] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:30.145] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:18:0) after 1m0s
[00:38:30.212] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:18:0)
[00:38:30.212] Timer tick, asking Buildbucket for the build status
[00:38:30.286] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:30.286] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:19:0) after 1m0s
[00:39:30.361] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:19:0)
[00:39:30.361] Timer tick, asking Buildbucket for the build status
[00:39:30.521] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:30.521] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:20:0) after 1m0s
[00:40:30.965] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:20:0)
[00:40:30.966] Timer tick, asking Buildbucket for the build status
[00:40:31.308] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:31.308] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:21:0) after 1m0s
[00:41:31.658] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:21:0)
[00:41:31.658] Timer tick, asking Buildbucket for the build status
[00:41:31.852] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:31.852] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:22:0) after 1m0s
[00:42:31.993] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:22:0)
[00:42:31.993] Timer tick, asking Buildbucket for the build status
[00:42:32.129] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:32.129] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:23:0) after 1m0s
[00:43:32.324] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:23:0)
[00:43:32.324] Timer tick, asking Buildbucket for the build status
[00:43:32.400] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:32.400] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:24:0) after 1m0s
[00:44:32.462] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:24:0)
[00:44:32.462] Timer tick, asking Buildbucket for the build status
[00:44:32.571] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:32.571] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:25:0) after 1m0s
[00:45:32.695] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:25:0)
[00:45:32.695] Timer tick, asking Buildbucket for the build status
[00:45:34.685] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:34.685] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:26:0) after 1m0s
[00:46:34.837] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:26:0)
[00:46:34.837] Timer tick, asking Buildbucket for the build status
[00:46:35.103] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:35.103] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:27:0) after 1m0s
[00:47:35.131] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:27:0)
[00:47:35.131] Timer tick, asking Buildbucket for the build status
[00:47:35.252] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:35.252] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:28:0) after 1m0s
[00:48:35.373] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:28:0)
[00:48:35.373] Timer tick, asking Buildbucket for the build status
[00:48:35.495] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:35.495] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:29:0) after 1m0s
[00:49:35.752] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:29:0)
[00:49:35.752] Timer tick, asking Buildbucket for the build status
[00:49:35.944] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:35.944] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:30:0) after 1m0s
[00:50:35.973] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:30:0)
[00:50:35.973] Timer tick, asking Buildbucket for the build status
[00:50:36.135] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:36.135] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:31:0) after 1m0s
[00:51:36.267] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:31:0)
[00:51:36.267] Timer tick, asking Buildbucket for the build status
[00:51:36.437] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:36.437] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:32:0) after 1m0s
[00:52:36.524] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:32:0)
[00:52:36.524] Timer tick, asking Buildbucket for the build status
[00:52:36.662] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:36.662] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:33:0) after 1m0s
[00:53:36.771] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:33:0)
[00:53:36.771] Timer tick, asking Buildbucket for the build status
[00:53:36.833] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:36.833] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:34:0) after 1m0s
[00:54:37.049] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:34:0)
[00:54:37.050] Timer tick, asking Buildbucket for the build status
[00:54:37.545] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:37.545] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:35:0) after 1m0s
[00:55:37.767] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:35:0)
[00:55:37.767] Timer tick, asking Buildbucket for the build status
[00:55:37.988] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:37.988] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:36:0) after 1m0s
[00:56:38.028] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:36:0)
[00:56:38.028] Timer tick, asking Buildbucket for the build status
[00:56:38.314] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:38.314] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:37:0) after 1m0s
[00:57:38.411] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:37:0)
[00:57:38.411] Timer tick, asking Buildbucket for the build status
[00:57:38.817] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:38.817] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:38:0) after 1m0s
[00:58:38.891] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:38:0)
[00:58:38.891] Timer tick, asking Buildbucket for the build status
[00:58:38.959] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:38.959] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:39:0) after 1m0s
[00:59:39.144] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:39:0)
[00:59:39.144] Timer tick, asking Buildbucket for the build status
[00:59:39.247] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:39.247] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:40:0) after 1m0s
[01:00:39.389] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:40:0)
[01:00:39.389] Timer tick, asking Buildbucket for the build status
[01:00:39.635] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:39.635] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:41:0) after 1m0s
[01:01:39.724] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:41:0)
[01:01:39.724] Timer tick, asking Buildbucket for the build status
[01:01:40.207] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:40.207] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:42:0) after 1m0s
[01:02:40.374] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:42:0)
[01:02:40.374] Timer tick, asking Buildbucket for the build status
[01:02:40.618] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:40.619] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:43:0) after 1m0s
[01:03:40.646] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:43:0)
[01:03:40.646] Timer tick, asking Buildbucket for the build status
[01:03:40.720] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:40.720] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:44:0) after 1m0s
[01:04:40.843] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:44:0)
[01:04:40.843] Timer tick, asking Buildbucket for the build status
[01:04:40.993] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:40.993] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:45:0) after 1m0s
[01:05:41.078] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:45:0)
[01:05:41.078] Timer tick, asking Buildbucket for the build status
[01:05:41.410] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:41.410] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:46:0) after 1m0s
[01:06:41.473] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:46:0)
[01:06:41.473] Timer tick, asking Buildbucket for the build status
[01:06:41.675] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:41.675] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:47:0) after 1m0s
[01:07:41.735] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:47:0)
[01:07:41.735] Timer tick, asking Buildbucket for the build status
[01:07:42.006] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:42.006] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:48:0) after 1m0s
[01:08:42.101] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:48:0)
[01:08:42.101] Timer tick, asking Buildbucket for the build status
[01:08:42.229] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:42.229] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:49:0) after 1m0s
[01:09:42.208] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:49:0)
[01:09:42.208] Timer tick, asking Buildbucket for the build status
[01:09:42.357] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:42.357] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:50:0) after 1m0s
[01:10:42.457] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:50:0)
[01:10:42.457] Timer tick, asking Buildbucket for the build status
[01:10:42.636] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:42.636] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:51:0) after 1m0s
[01:11:42.725] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:51:0)
[01:11:42.725] Timer tick, asking Buildbucket for the build status
[01:11:42.938] Build 8872579176016460656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:42.938] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:9038009238258465440:52:0) after 1m0s
[01:11:44.440] Received PubSub notification, asking Buildbucket for the build status
[01:11:44.530] Build 8872579176016460656: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:11:44.530] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1596849103524043",
"created_by": "project:chromium",
"created_ts": "1596846141760497",
"id": "8872579176016460656",
"parameters_json": "{\"builder_name\": \"Mac deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d5c373d14d6897466ff37ab6f884aedabcce0da6\"}}",
"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\": 39969, \"clang_revision\": \"llvmorg-12-init-1771-g1bd7046e-3\", \"got_angle_revision\": \"1dcb3eb267e9853e6f02d05ad637da357bf62687\", \"got_dawn_revision\": \"2cf5a08cfc1b759ceb0b6f504ca5954f6d442b09\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"d5c373d14d6897466ff37ab6f884aedabcce0da6\", \"got_revision_cp\": \"refs/heads/master@{#796182}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"59b4828f293eb16f8983ae9ea0a8a0a84cf8174c\", \"got_v8_revision\": \"4f52dde736e657ac01cf74a6cdc38c752f9a5dae\", \"got_v8_revision_cp\": \"refs/heads/8.6.337@{#1}\", \"got_webrtc_revision\": \"4c2f9c90f42591f0935b496d61ee256ebf53198f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31887}\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d5c373d14d6897466ff37ab6f884aedabcce0da6\"}, \"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\": [\"5472-d0af7f3\"], \"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": "1596846143890894",
"status": "COMPLETED",
"status_changed_ts": "1596849103933233",
"tags": [
"build_address:luci.chromium.ci/Mac deterministic/39969",
"builder:Mac deterministic",
"buildset:commit/git/d5c373d14d6897466ff37ab6f884aedabcce0da6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d5c373d14d6897466ff37ab6f884aedabcce0da6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038009238258465440",
"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/8872579176016460656/+/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:4de443fdac94b010",
"user_agent:luci-scheduler"
],
"updated_ts": "1596849103941193",
"url": "https://ci.chromium.org/b/8872579176016460656",
"utcnow_ts": "1596849104520216"
}
}
[01:11:44.530] Invocation finished in 49m24.292365591s with status SUCCEEDED