[04:00:18.119] New invocation is queued and will start shortly
[04:00:19.315] Starting the invocation (attempt 1)
[04:00:19.344] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:19.344] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:19.344] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021416280270725936",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c8b43035c25423ed9a689020217236efd572e443\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9021416280270725936",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/c8b43035c25423ed9a689020217236efd572e443",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8b43035c25423ed9a689020217236efd572e443",
"gitiles_ref:refs/heads/master"
]
}
[04:00:19.963] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612670419420429",
"id": "8855986218244188272",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c8b43035c25423ed9a689020217236efd572e443\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612670419793451",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/17629",
"builder:ToTiOS",
"buildset:commit/git/c8b43035c25423ed9a689020217236efd572e443",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8b43035c25423ed9a689020217236efd572e443",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021416280270725936",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855986218244188272/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1612670419793572",
"url": "https://ci.chromium.org/b/8855986218244188272",
"utcnow_ts": "1612670419955758"
}
}
[04:00:19.963] Task URL: https://ci.chromium.org/b/8855986218244188272
[04:00:19.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:2:0) after 1m0s
[04:01:20.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:2:0)
[04:01:20.045] Timer tick, asking Buildbucket for the build status
[04:01:20.131] Build 8855986218244188272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:20.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:3:0) after 1m0s
[04:02:20.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:3:0)
[04:02:20.122] Timer tick, asking Buildbucket for the build status
[04:02:20.292] Build 8855986218244188272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:20.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:4:0) after 1m0s
[04:03:20.326] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:4:0)
[04:03:20.326] Timer tick, asking Buildbucket for the build status
[04:03:20.595] Build 8855986218244188272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:20.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:5:0) after 1m0s
[04:04:20.614] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:5:0)
[04:04:20.614] Timer tick, asking Buildbucket for the build status
[04:04:21.360] Build 8855986218244188272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:21.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:6:0) after 1m0s
[04:05:21.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:6:0)
[04:05:21.380] Timer tick, asking Buildbucket for the build status
[04:05:21.863] Build 8855986218244188272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:21.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:7:0) after 1m0s
[04:06:07.840] Received PubSub notification, asking Buildbucket for the build status
[04:06:08.276] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:21.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:7:0)
[04:06:21.936] Timer tick, asking Buildbucket for the build status
[04:06:22.128] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:22.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:9:0) after 1m0s
[04:07:22.148] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:9:0)
[04:07:22.148] Timer tick, asking Buildbucket for the build status
[04:07:22.435] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:22.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:10:0) after 1m0s
[04:08:23.708] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:10:0)
[04:08:23.708] Timer tick, asking Buildbucket for the build status
[04:08:24.103] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:24.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:11:0) after 1m0s
[04:09:24.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:11:0)
[04:09:24.196] Timer tick, asking Buildbucket for the build status
[04:09:24.266] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:24.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:12:0) after 1m0s
[04:10:24.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:12:0)
[04:10:24.262] Timer tick, asking Buildbucket for the build status
[04:10:24.647] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:24.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:13:0) after 1m0s
[04:11:24.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:13:0)
[04:11:24.691] Timer tick, asking Buildbucket for the build status
[04:11:24.757] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:24.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:14:0) after 1m0s
[04:12:24.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:14:0)
[04:12:24.778] Timer tick, asking Buildbucket for the build status
[04:12:24.846] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:24.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:15:0) after 1m0s
[04:13:24.930] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:15:0)
[04:13:24.930] Timer tick, asking Buildbucket for the build status
[04:13:25.048] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:25.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:16:0) after 1m0s
[04:14:25.160] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:16:0)
[04:14:25.160] Timer tick, asking Buildbucket for the build status
[04:14:25.213] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:25.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:17:0) after 1m0s
[04:15:25.312] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:17:0)
[04:15:25.312] Timer tick, asking Buildbucket for the build status
[04:15:25.416] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:25.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:18:0) after 1m0s
[04:16:25.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:18:0)
[04:16:25.462] Timer tick, asking Buildbucket for the build status
[04:16:25.773] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:25.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:19:0) after 1m0s
[04:17:25.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:19:0)
[04:17:25.790] Timer tick, asking Buildbucket for the build status
[04:17:25.850] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:25.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:20:0) after 1m0s
[04:18:25.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:20:0)
[04:18:25.878] Timer tick, asking Buildbucket for the build status
[04:18:26.029] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:26.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:21:0) after 1m0s
[04:19:26.040] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:21:0)
[04:19:26.041] Timer tick, asking Buildbucket for the build status
[04:19:26.304] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:26.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:22:0) after 1m0s
[04:20:26.313] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:22:0)
[04:20:26.313] Timer tick, asking Buildbucket for the build status
[04:20:26.953] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:26.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:23:0) after 1m0s
[04:21:26.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:23:0)
[04:21:26.971] Timer tick, asking Buildbucket for the build status
[04:21:27.058] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:27.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:24:0) after 1m0s
[04:22:27.077] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:24:0)
[04:22:27.077] Timer tick, asking Buildbucket for the build status
[04:22:27.133] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:27.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:25:0) after 1m0s
[04:23:27.204] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:25:0)
[04:23:27.204] Timer tick, asking Buildbucket for the build status
[04:23:27.398] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:27.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:26:0) after 1m0s
[04:24:27.685] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:26:0)
[04:24:27.685] Timer tick, asking Buildbucket for the build status
[04:24:27.803] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:27.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:27:0) after 1m0s
[04:25:27.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:27:0)
[04:25:27.935] Timer tick, asking Buildbucket for the build status
[04:25:28.105] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:28.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:28:0) after 1m0s
[04:26:28.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:28:0)
[04:26:28.262] Timer tick, asking Buildbucket for the build status
[04:26:28.350] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:28.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:29:0) after 1m0s
[04:27:28.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:29:0)
[04:27:28.440] Timer tick, asking Buildbucket for the build status
[04:27:28.507] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:28.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:30:0) after 1m0s
[04:28:28.607] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:30:0)
[04:28:28.607] Timer tick, asking Buildbucket for the build status
[04:28:28.683] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:28.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:31:0) after 1m0s
[04:29:28.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:31:0)
[04:29:28.824] Timer tick, asking Buildbucket for the build status
[04:29:28.900] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:28.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:32:0) after 1m0s
[04:30:29.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:32:0)
[04:30:29.131] Timer tick, asking Buildbucket for the build status
[04:30:29.239] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:29.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:33:0) after 1m0s
[04:31:29.480] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:33:0)
[04:31:29.480] Timer tick, asking Buildbucket for the build status
[04:31:29.611] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:29.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:34:0) after 1m0s
[04:32:29.765] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:34:0)
[04:32:29.765] Timer tick, asking Buildbucket for the build status
[04:32:29.821] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:29.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:35:0) after 1m0s
[04:33:29.899] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:35:0)
[04:33:29.899] Timer tick, asking Buildbucket for the build status
[04:33:30.163] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:30.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:36:0) after 1m0s
[04:34:30.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:36:0)
[04:34:30.418] Timer tick, asking Buildbucket for the build status
[04:34:30.521] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:30.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:37:0) after 1m0s
[04:35:30.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:37:0)
[04:35:30.582] Timer tick, asking Buildbucket for the build status
[04:35:30.683] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:30.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:38:0) after 1m0s
[04:36:30.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:38:0)
[04:36:30.776] Timer tick, asking Buildbucket for the build status
[04:36:30.834] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:30.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:39:0) after 1m0s
[04:37:30.845] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:39:0)
[04:37:30.845] Timer tick, asking Buildbucket for the build status
[04:37:30.911] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:30.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:40:0) after 1m0s
[04:38:30.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:40:0)
[04:38:30.929] Timer tick, asking Buildbucket for the build status
[04:38:32.544] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:32.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:41:0) after 1m0s
[04:39:32.681] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:41:0)
[04:39:32.681] Timer tick, asking Buildbucket for the build status
[04:39:32.898] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:32.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:42:0) after 1m0s
[04:40:32.985] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:42:0)
[04:40:32.985] Timer tick, asking Buildbucket for the build status
[04:40:33.238] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:33.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:43:0) after 1m0s
[04:41:33.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:43:0)
[04:41:33.258] Timer tick, asking Buildbucket for the build status
[04:41:33.524] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:33.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:44:0) after 1m0s
[04:42:33.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:44:0)
[04:42:33.544] Timer tick, asking Buildbucket for the build status
[04:42:33.698] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:33.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:45:0) after 1m0s
[04:43:33.718] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:45:0)
[04:43:33.718] Timer tick, asking Buildbucket for the build status
[04:43:33.808] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:33.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:46:0) after 1m0s
[04:44:33.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:46:0)
[04:44:33.896] Timer tick, asking Buildbucket for the build status
[04:44:33.949] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:33.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:47:0) after 1m0s
[04:45:34.000] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:47:0)
[04:45:34.000] Timer tick, asking Buildbucket for the build status
[04:45:34.125] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:34.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:48:0) after 1m0s
[04:46:34.214] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:48:0)
[04:46:34.214] Timer tick, asking Buildbucket for the build status
[04:46:34.289] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:34.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:49:0) after 1m0s
[04:47:34.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:49:0)
[04:47:34.402] Timer tick, asking Buildbucket for the build status
[04:47:34.513] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:34.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:50:0) after 1m0s
[04:48:34.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:50:0)
[04:48:34.519] Timer tick, asking Buildbucket for the build status
[04:48:35.222] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:35.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:51:0) after 1m0s
[04:49:35.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:51:0)
[04:49:35.370] Timer tick, asking Buildbucket for the build status
[04:49:35.434] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:35.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:52:0) after 1m0s
[04:50:35.430] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:52:0)
[04:50:35.430] Timer tick, asking Buildbucket for the build status
[04:50:35.521] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:35.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:53:0) after 1m0s
[04:51:35.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:53:0)
[04:51:35.613] Timer tick, asking Buildbucket for the build status
[04:51:35.690] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:35.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:54:0) after 1m0s
[04:52:35.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:54:0)
[04:52:35.743] Timer tick, asking Buildbucket for the build status
[04:52:35.791] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:35.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:55:0) after 1m0s
[04:53:35.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:55:0)
[04:53:35.855] Timer tick, asking Buildbucket for the build status
[04:53:36.002] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:36.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:56:0) after 1m0s
[04:54:36.116] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:56:0)
[04:54:36.116] Timer tick, asking Buildbucket for the build status
[04:54:36.280] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:36.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:57:0) after 1m0s
[04:55:36.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:57:0)
[04:55:36.334] Timer tick, asking Buildbucket for the build status
[04:55:36.642] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:36.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:58:0) after 1m0s
[04:56:36.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:58:0)
[04:56:36.692] Timer tick, asking Buildbucket for the build status
[04:56:36.780] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:36.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:59:0) after 1m0s
[04:57:36.849] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:59:0)
[04:57:36.849] Timer tick, asking Buildbucket for the build status
[04:57:36.918] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:36.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:60:0) after 1m0s
[04:58:37.008] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:60:0)
[04:58:37.008] Timer tick, asking Buildbucket for the build status
[04:58:37.473] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:37.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:61:0) after 1m0s
[04:59:37.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:61:0)
[04:59:37.473] Timer tick, asking Buildbucket for the build status
[04:59:37.550] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:37.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:62:0) after 1m0s
[05:00:37.632] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:62:0)
[05:00:37.632] Timer tick, asking Buildbucket for the build status
[05:00:39.046] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:39.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:63:0) after 1m0s
[05:01:39.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:63:0)
[05:01:39.068] Timer tick, asking Buildbucket for the build status
[05:01:39.175] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:39.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:64:0) after 1m0s
[05:02:39.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:64:0)
[05:02:39.196] Timer tick, asking Buildbucket for the build status
[05:02:39.372] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:39.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:65:0) after 1m0s
[05:03:39.429] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:65:0)
[05:03:39.429] Timer tick, asking Buildbucket for the build status
[05:03:39.590] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:39.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:66:0) after 1m0s
[05:04:39.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:66:0)
[05:04:39.589] Timer tick, asking Buildbucket for the build status
[05:04:39.711] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:39.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:67:0) after 1m0s
[05:05:39.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:67:0)
[05:05:39.744] Timer tick, asking Buildbucket for the build status
[05:05:40.624] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:40.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:68:0) after 1m0s
[05:06:40.683] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:68:0)
[05:06:40.683] Timer tick, asking Buildbucket for the build status
[05:06:40.815] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:40.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:69:0) after 1m0s
[05:07:40.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:69:0)
[05:07:40.940] Timer tick, asking Buildbucket for the build status
[05:07:41.028] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:41.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:70:0) after 1m0s
[05:08:41.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:70:0)
[05:08:41.126] Timer tick, asking Buildbucket for the build status
[05:08:41.634] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:41.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:71:0) after 1m0s
[05:09:41.651] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:71:0)
[05:09:41.651] Timer tick, asking Buildbucket for the build status
[05:09:41.792] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:41.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:72:0) after 1m0s
[05:10:41.816] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:72:0)
[05:10:41.816] Timer tick, asking Buildbucket for the build status
[05:10:42.163] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:42.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:73:0) after 1m0s
[05:11:42.237] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:73:0)
[05:11:42.237] Timer tick, asking Buildbucket for the build status
[05:11:42.398] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:42.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:74:0) after 1m0s
[05:12:42.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:74:0)
[05:12:42.375] Timer tick, asking Buildbucket for the build status
[05:12:42.587] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:42.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:75:0) after 1m0s
[05:13:42.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:75:0)
[05:13:42.611] Timer tick, asking Buildbucket for the build status
[05:13:42.764] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:42.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:76:0) after 1m0s
[05:14:42.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:76:0)
[05:14:42.782] Timer tick, asking Buildbucket for the build status
[05:14:42.861] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:42.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:77:0) after 1m0s
[05:15:42.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:77:0)
[05:15:42.888] Timer tick, asking Buildbucket for the build status
[05:15:43.352] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:43.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:78:0) after 1m0s
[05:16:43.349] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:78:0)
[05:16:43.349] Timer tick, asking Buildbucket for the build status
[05:16:43.482] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:43.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:79:0) after 1m0s
[05:17:43.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:79:0)
[05:17:43.464] Timer tick, asking Buildbucket for the build status
[05:17:43.599] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:43.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:80:0) after 1m0s
[05:18:43.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:80:0)
[05:18:43.687] Timer tick, asking Buildbucket for the build status
[05:18:43.746] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:43.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:81:0) after 1m0s
[05:19:43.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:81:0)
[05:19:43.823] Timer tick, asking Buildbucket for the build status
[05:19:43.882] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:43.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:82:0) after 1m0s
[05:20:43.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:82:0)
[05:20:43.911] Timer tick, asking Buildbucket for the build status
[05:20:44.096] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:44.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:83:0) after 1m0s
[05:21:44.120] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:83:0)
[05:21:44.120] Timer tick, asking Buildbucket for the build status
[05:21:44.171] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:44.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:84:0) after 1m0s
[05:22:44.272] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:84:0)
[05:22:44.272] Timer tick, asking Buildbucket for the build status
[05:22:44.331] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:44.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:85:0) after 1m0s
[05:23:44.837] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:85:0)
[05:23:44.837] Timer tick, asking Buildbucket for the build status
[05:23:44.975] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:44.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:86:0) after 1m0s
[05:24:45.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:86:0)
[05:24:45.293] Timer tick, asking Buildbucket for the build status
[05:24:45.569] Build 8855986218244188272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:45.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9021416280270725936:87:0) after 1m0s
[05:25:15.391] Received PubSub notification, asking Buildbucket for the build status
[05:25:15.544] Build 8855986218244188272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:25:15.544] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612675514297978",
"created_by": "project:chromium",
"created_ts": "1612670419420429",
"id": "8855986218244188272",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c8b43035c25423ed9a689020217236efd572e443\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"c8b43035c25423ed9a689020217236efd572e443\", \"project\": \"chromium/src\"}], \"$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\": \"build717-m9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTiOS\", \"buildnumber\": 17629, \"clang_revision\": \"llvmorg-13-init-794-g83e2710e-1\", \"got_angle_revision\": \"d820ec7b3e5f9412d1ceb55d31b3f7dc09e3d16d\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"c8b43035c25423ed9a689020217236efd572e443\", \"got_revision_cp\": \"refs/heads/master@{#851516}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"711403215714087a74f05b1382b18e4c318be936\", \"got_v8_revision_cp\": \"refs/heads/9.0.137@{#1}\", \"got_webrtc_revision\": \"d42413a4b4636422ba5ea66ba40e7d24fb64f9b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33183}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c8b43035c25423ed9a689020217236efd572e443\", \"swarm_hashes_refs/heads/master(at){#851516}_without_patch\": {\"absl_hardening_tests\": \"67a3319377b0561fe191a17f9407ac42011fc8c5\", \"base_unittests\": \"71fbccbaba6e8c184277a282ea67bf4b34d56d18\", \"boringssl_crypto_tests\": \"fb40f11554eaa86d583cca615d6b8be560fd2af3\", \"boringssl_ssl_tests\": \"ab9ea9ad435b7729d1719d04c868ab702e88b743\", \"components_unittests\": \"ebbd53f398f5b1634d0008828f14c977ed620bc6\", \"crypto_unittests\": \"93cc7be761c9a2e5b3af307179fd8dfcfe8cc0af\", \"gfx_unittests\": \"5b3aacf70aa0dda392027c7c2e6e9319b1ca4aee\", \"google_apis_unittests\": \"7ca1de734c6686f8dae5bdd14b392461fcaa23b7\", \"ios_chrome_unittests\": \"c8937346d607825526bf5513c0b2fcd390e58a97\", \"ios_net_unittests\": \"cdf3b39975724f6eac07ec4a993234db46f8240d\", \"ios_web_inttests\": \"31f740f20103cd65b6daaf91b9274e5cb8a0d9a2\", \"ios_web_unittests\": \"030904da096627eb1e12bc88e54506296b897273\", \"ios_web_view_inttests\": \"4aa58c876c8f5969fde51fdae7acc68736bd2d5b\", \"net_unittests\": \"20d5a3abebedb9341e394c64f1837bf05d13849b\", \"skia_unittests\": \"589ea6fc4d592f476e00d72fdfb5f5a3a0f7cd7d\", \"sql_unittests\": \"bc20b8bc3b737b553d15bec52e740dae8e14d51b\", \"ui_base_unittests\": \"5d7683cf2604b627ebb57ed765d6cb359231bea1\", \"url_unittests\": \"692fb716a3485a1ecd3a0559d63def4a27a02d67\"}, \"xcode_build_version\": \"12a7209\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"ToTiOS\", \"ToTiOSDevice\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_12a7209\"], \"cores\": [\"12\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-i7-8700B\"], \"gce\": [\"0\"], \"gpu\": [\"8086\", \"8086:3e9b\"], \"hidpi\": [\"0\"], \"id\": [\"build717-m9\"], \"mac_model\": [\"Macmini8,1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Mac\", \"Mac-10\", \"Mac-10.15\", \"Mac-10.15.6\", \"Mac-10.15.6-19G2021\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.16\"], \"server_version\": [\"5676-c76598c\"], \"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": "1612670767129361",
"status": "COMPLETED",
"status_changed_ts": "1612675515130374",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/17629",
"builder:ToTiOS",
"buildset:commit/git/c8b43035c25423ed9a689020217236efd572e443",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8b43035c25423ed9a689020217236efd572e443",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021416280270725936",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855986218244188272/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:5193774e75319510",
"user_agent:luci-scheduler"
],
"updated_ts": "1612675515135052",
"url": "https://ci.chromium.org/b/8855986218244188272",
"utcnow_ts": "1612675515526267"
}
}
[05:25:15.544] Invocation finished in 1h24m57.439900027s with status SUCCEEDED