[15:43:47.673] New invocation is queued and will start shortly
[15:43:48.839] Starting the invocation (attempt 1)
[15:43:48.868] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1a9dec29bf7faeef5ad1be2592dd64bb864d64c"
[15:43:48.868] Popped gitiles commit info from properties and tags
[15:43:48.868] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:43:48.870] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:43:48.870] Buildbucket request:
{
"requestId": "9017566947758106096",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b1a9dec29bf7faeef5ad1be2592dd64bb864d64c",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017566947758106096"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTiOSDevice"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:43:49.428] Scheduled build:
{
"id": "8852136885776991328",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 21755,
"createdBy": "project:chromium",
"createTime": "2021-03-21T15:43:48.930435Z",
"updateTime": "2021-03-21T15:43:49.343385Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b1a9dec29bf7faeef5ad1be2592dd64bb864d64c",
"ref": "refs/heads/master"
}
}
}
[15:43:49.428] Task URL: https://cr-buildbucket.appspot.com/build/8852136885776991328
[15:43:49.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:2:0) after 2m56s
[15:46:42.720] Received PubSub notification, asking Buildbucket for the build status
[15:46:42.747] Build status: STARTED
[15:46:45.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:2:0)
[15:46:45.469] Build status: STARTED
[15:46:45.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:4:0) after 9m12s
[15:55:57.488] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:4:0)
[15:55:57.516] Build status: STARTED
[15:55:57.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:5:0) after 5m13s
[16:01:10.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:5:0)
[16:01:10.558] Build status: STARTED
[16:01:10.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:6:0) after 9m45s
[16:10:55.587] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:6:0)
[16:10:55.615] Build status: STARTED
[16:10:55.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:7:0) after 6m47s
[16:17:42.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:7:0)
[16:17:42.762] Build status: STARTED
[16:17:42.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:8:0) after 4m54s
[16:22:36.808] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:8:0)
[16:22:36.808] Timer tick, asking Buildbucket for the build status
[16:22:36.934] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:36.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:9:0) after 1m0s
[16:23:37.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:9:0)
[16:23:37.124] Timer tick, asking Buildbucket for the build status
[16:23:37.190] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:37.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:10:0) after 1m0s
[16:24:37.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:10:0)
[16:24:38.006] Build status: STARTED
[16:24:38.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:11:0) after 5m49s
[16:30:27.023] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:11:0)
[16:30:27.065] Build status: STARTED
[16:30:27.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:12:0) after 9m52s
[16:40:19.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:12:0)
[16:40:19.132] Timer tick, asking Buildbucket for the build status
[16:40:19.495] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:19.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:13:0) after 1m0s
[16:41:19.518] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:13:0)
[16:41:19.518] Timer tick, asking Buildbucket for the build status
[16:41:19.752] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:19.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:14:0) after 1m0s
[16:42:19.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:14:0)
[16:42:19.793] Build status: STARTED
[16:42:19.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:15:0) after 1m47s
[16:44:06.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:15:0)
[16:44:06.955] Build status: STARTED
[16:44:06.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:16:0) after 6m51s
[16:50:57.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:16:0)
[16:50:57.970] Timer tick, asking Buildbucket for the build status
[16:50:58.182] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:58.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:17:0) after 1m0s
[16:51:58.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:17:0)
[16:51:58.203] Timer tick, asking Buildbucket for the build status
[16:51:58.270] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:58.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:18:0) after 1m0s
[16:52:58.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:18:0)
[16:52:58.848] Timer tick, asking Buildbucket for the build status
[16:52:59.072] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:59.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:19:0) after 1m0s
[16:53:59.067] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:19:0)
[16:53:59.092] Build status: STARTED
[16:53:59.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:20:0) after 8m1s
[17:02:00.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:20:0)
[17:02:00.165] Build status: STARTED
[17:02:00.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:21:0) after 9m48s
[17:11:48.192] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:21:0)
[17:11:48.218] Build status: STARTED
[17:11:48.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:22:0) after 8m53s
[17:20:41.700] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:22:0)
[17:20:41.700] Timer tick, asking Buildbucket for the build status
[17:20:41.792] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:41.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:23:0) after 1m0s
[17:21:41.815] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:23:0)
[17:21:41.815] Timer tick, asking Buildbucket for the build status
[17:21:41.930] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:41.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:24:0) after 1m0s
[17:22:41.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:24:0)
[17:22:41.974] Build status: STARTED
[17:22:41.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:25:0) after 3m20s
[17:26:01.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:25:0)
[17:26:02.005] Build status: STARTED
[17:26:02.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:26:0) after 3m59s
[17:30:01.023] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:26:0)
[17:30:01.055] Build status: STARTED
[17:30:01.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:27:0) after 8m17s
[17:38:18.070] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:27:0)
[17:38:18.070] Timer tick, asking Buildbucket for the build status
[17:38:18.147] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:28:0) after 1m0s
[17:39:18.165] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:28:0)
[17:39:18.165] Timer tick, asking Buildbucket for the build status
[17:39:18.302] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:18.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:29:0) after 1m0s
[17:40:18.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:29:0)
[17:40:18.318] Timer tick, asking Buildbucket for the build status
[17:40:18.441] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:18.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:30:0) after 1m0s
[17:41:18.459] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:30:0)
[17:41:18.685] Build status: STARTED
[17:41:18.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:31:0) after 9m30s
[17:50:48.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:31:0)
[17:50:48.765] Build status: STARTED
[17:50:48.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:32:0) after 9m14s
[18:00:02.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:32:0)
[18:00:02.789] Timer tick, asking Buildbucket for the build status
[18:00:02.936] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:02.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:33:0) after 1m0s
[18:01:02.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:33:0)
[18:01:02.994] Build status: STARTED
[18:01:02.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:34:0) after 5m52s
[18:06:55.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:34:0)
[18:06:55.065] Build status: STARTED
[18:06:55.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:35:0) after 4m22s
[18:11:17.095] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:35:0)
[18:11:17.123] Build status: STARTED
[18:11:17.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:36:0) after 2m35s
[18:13:55.438] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:36:0)
[18:13:55.473] Build status: STARTED
[18:13:55.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:37:0) after 8m2s
[18:21:57.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:37:0)
[18:21:57.719] Build status: STARTED
[18:21:57.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:38:0) after 8m35s
[18:30:32.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:38:0)
[18:30:32.916] Build status: STARTED
[18:30:32.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:39:0) after 3m56s
[18:34:29.072] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:39:0)
[18:34:29.102] Build status: STARTED
[18:34:29.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:40:0) after 1m9s
[18:35:38.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:40:0)
[18:35:38.124] Timer tick, asking Buildbucket for the build status
[18:35:41.966] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:41.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:41:0) after 1m0s
[18:36:42.040] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:41:0)
[18:36:42.040] Timer tick, asking Buildbucket for the build status
[18:36:42.104] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:42.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:42:0) after 1m0s
[18:37:42.235] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:42:0)
[18:37:42.264] Build status: STARTED
[18:37:42.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:43:0) after 3m26s
[18:41:08.284] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:43:0)
[18:41:08.284] Timer tick, asking Buildbucket for the build status
[18:41:08.429] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:08.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:44:0) after 1m0s
[18:42:08.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:44:0)
[18:42:08.502] Timer tick, asking Buildbucket for the build status
[18:42:08.571] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:08.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:45:0) after 1m0s
[18:43:08.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:45:0)
[18:43:08.617] Build status: STARTED
[18:43:08.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:46:0) after 9m19s
[18:52:27.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:46:0)
[18:52:27.633] Timer tick, asking Buildbucket for the build status
[18:52:27.803] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:27.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:47:0) after 1m0s
[18:53:27.820] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:47:0)
[18:53:27.820] Timer tick, asking Buildbucket for the build status
[18:53:27.881] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:27.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:48:0) after 1m0s
[18:54:27.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:48:0)
[18:54:27.890] Build status: STARTED
[18:54:27.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:49:0) after 8m2s
[19:02:29.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:49:0)
[19:02:29.914] Timer tick, asking Buildbucket for the build status
[19:02:29.996] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:29.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:50:0) after 1m0s
[19:03:30.020] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:50:0)
[19:03:30.020] Timer tick, asking Buildbucket for the build status
[19:03:30.096] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:30.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:51:0) after 1m0s
[19:04:30.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:51:0)
[19:04:30.152] Build status: STARTED
[19:04:30.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:52:0) after 7m39s
[19:12:09.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:52:0)
[19:12:09.196] Timer tick, asking Buildbucket for the build status
[19:12:09.305] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:09.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:53:0) after 1m0s
[19:13:09.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:53:0)
[19:13:09.322] Timer tick, asking Buildbucket for the build status
[19:13:09.450] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:09.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:54:0) after 1m0s
[19:14:09.558] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:54:0)
[19:14:09.581] Build status: STARTED
[19:14:09.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:55:0) after 6m22s
[19:20:31.614] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:55:0)
[19:20:31.657] Build status: STARTED
[19:20:31.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:56:0) after 2m52s
[19:23:23.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:56:0)
[19:23:23.701] Timer tick, asking Buildbucket for the build status
[19:23:23.795] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:23.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:57:0) after 1m0s
[19:24:23.892] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:57:0)
[19:24:23.892] Timer tick, asking Buildbucket for the build status
[19:24:23.970] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:23.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:58:0) after 1m0s
[19:25:24.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:58:0)
[19:25:24.024] Timer tick, asking Buildbucket for the build status
[19:25:24.095] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:24.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:59:0) after 1m0s
[19:26:24.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:59:0)
[19:26:24.122] Timer tick, asking Buildbucket for the build status
[19:26:24.197] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:24.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:60:0) after 1m0s
[19:27:24.320] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:60:0)
[19:27:24.320] Timer tick, asking Buildbucket for the build status
[19:27:24.476] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:24.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:61:0) after 1m0s
[19:28:24.496] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:61:0)
[19:28:24.496] Timer tick, asking Buildbucket for the build status
[19:28:24.722] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:24.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:62:0) after 1m0s
[19:29:24.857] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:62:0)
[19:29:24.857] Timer tick, asking Buildbucket for the build status
[19:29:25.117] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:25.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:63:0) after 1m0s
[19:30:25.142] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:63:0)
[19:30:25.142] Timer tick, asking Buildbucket for the build status
[19:30:25.468] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:25.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:64:0) after 1m0s
[19:31:25.499] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:64:0)
[19:31:25.499] Timer tick, asking Buildbucket for the build status
[19:31:25.575] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:25.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:65:0) after 1m0s
[19:32:25.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:65:0)
[19:32:25.805] Timer tick, asking Buildbucket for the build status
[19:32:25.932] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:25.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:66:0) after 1m0s
[19:33:25.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:66:0)
[19:33:25.949] Timer tick, asking Buildbucket for the build status
[19:33:26.225] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:26.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:67:0) after 1m0s
[19:34:26.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:67:0)
[19:34:26.253] Timer tick, asking Buildbucket for the build status
[19:34:26.330] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:26.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:68:0) after 1m0s
[19:35:26.349] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:68:0)
[19:35:26.374] Build status: STARTED
[19:35:26.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:69:0) after 6m19s
[19:41:45.394] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:69:0)
[19:41:45.418] Build status: STARTED
[19:41:45.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:70:0) after 2m1s
[19:43:46.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:70:0)
[19:43:46.463] Timer tick, asking Buildbucket for the build status
[19:43:46.546] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:46.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:71:0) after 1m0s
[19:44:46.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:71:0)
[19:44:46.580] Timer tick, asking Buildbucket for the build status
[19:44:46.737] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:46.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:72:0) after 1m0s
[19:45:46.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:72:0)
[19:45:46.785] Build status: STARTED
[19:45:46.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:73:0) after 3m29s
[19:49:15.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:73:0)
[19:49:15.818] Timer tick, asking Buildbucket for the build status
[19:49:15.901] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:15.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:74:0) after 1m0s
[19:50:16.246] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:74:0)
[19:50:16.270] Build status: STARTED
[19:50:16.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:75:0) after 5m4s
[19:55:20.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:75:0)
[19:55:20.300] Timer tick, asking Buildbucket for the build status
[19:55:20.388] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:20.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:76:0) after 1m0s
[19:56:20.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:76:0)
[19:56:20.538] Build status: STARTED
[19:56:20.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:77:0) after 7m35s
[20:03:55.510] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:77:0)
[20:03:55.510] Timer tick, asking Buildbucket for the build status
[20:03:55.760] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:55.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:78:0) after 1m0s
[20:04:55.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:78:0)
[20:04:55.788] Timer tick, asking Buildbucket for the build status
[20:04:55.882] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:55.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:79:0) after 1m0s
[20:05:55.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:79:0)
[20:05:55.906] Timer tick, asking Buildbucket for the build status
[20:05:56.134] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:56.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:80:0) after 1m0s
[20:06:56.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:80:0)
[20:06:56.154] Timer tick, asking Buildbucket for the build status
[20:06:56.385] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:56.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:81:0) after 1m0s
[20:07:56.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:81:0)
[20:07:56.386] Timer tick, asking Buildbucket for the build status
[20:07:56.643] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:56.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:82:0) after 1m0s
[20:08:56.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:82:0)
[20:08:56.667] Timer tick, asking Buildbucket for the build status
[20:08:56.734] Build 8852136885776991328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:56.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:83:0) after 1m0s
[20:09:56.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:83:0)
[20:09:56.818] Build status: STARTED
[20:09:56.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:84:0) after 3m39s
[20:13:35.839] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:84:0)
[20:13:35.889] Build status: STARTED
[20:13:35.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:85:0) after 9m2s
[20:22:37.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:85:0)
[20:22:38.011] Build status: STARTED
[20:22:38.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017566947758106096:86:0) after 6m52s
[20:24:05.682] Received PubSub notification, asking Buildbucket for the build status
[20:24:05.757] Build 8852136885776991328: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:24:05.757] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616358245164995",
"created_by": "project:chromium",
"created_ts": "1616341428930435",
"failure_reason": "BUILD_FAILURE",
"id": "8852136885776991328",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**ios_chrome_unittests_iPhone 6S 12.3.1** failed because of:\\n\\n- SharingCoordinatorTest.Start_ShareCurrentPage\"}, \"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\": \"b1a9dec29bf7faeef5ad1be2592dd64bb864d64c\", \"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\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 21755, \"clang_revision\": \"llvmorg-13-init-4720-g7bafe336-1\", \"got_angle_revision\": \"90cf278c36871437c89b8f88d62e6a538b51501d\", \"got_dawn_revision\": \"6b80743d3f5bb389665590585c43eeb9cfa70a34\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"b1a9dec29bf7faeef5ad1be2592dd64bb864d64c\", \"got_revision_cp\": \"refs/heads/master@{#864998}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"6092f990f654f2d7a4534ee8c5bbb5c4fb800bdc\", \"got_v8_revision_cp\": \"refs/heads/9.1.170@{#1}\", \"got_webrtc_revision\": \"8bf1cd1c665a538a366bce4770acbb990b025388\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33513}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"swarm_hashes_refs/heads/master(at){#864998}_without_patch\": {\"absl_hardening_tests\": \"6a69c9e85176c6fdfeb2b6bc2d1c1343ee194d09\", \"base_unittests\": \"55eafe7c34c9957b9079de335855f3e4523cacc0\", \"boringssl_crypto_tests\": \"1c0c498b214978e7a27dbda165e18859238c186f\", \"boringssl_ssl_tests\": \"9b16882ed5ed664cc77bfe03362cf98538a2feee\", \"components_unittests\": \"4dce53ed6e72f377eedf165a8f4469f433dd2ce7\", \"crypto_unittests\": \"65761eca2e28e8d36544aa28166397c153c3f18c\", \"gfx_unittests\": \"f70c8563ee3e2ea2ccceecafff6fc5271db620bf\", \"google_apis_unittests\": \"708afb5df729c3fddd288efff45e6e5bb2fd1056\", \"ios_chrome_unittests\": \"f63846d4488a9fc3d1ebd2a6e061a009e9753e11\", \"ios_net_unittests\": \"d8a7edcd9b706ce9745fa9a8a979b5d0a6846d80\", \"ios_web_inttests\": \"40e21b56ee52324247a348cd7ae8619e9ed8a8bc\", \"ios_web_unittests\": \"0ab85f31354e8403e94e2a6901e62c6ca60947cb\", \"ios_web_view_inttests\": \"d478e86908d91a1202c489382cfdf3402142f021\", \"net_unittests\": \"df179ad17e603f7c4b7a48b03931aa1a6c18cffb\", \"skia_unittests\": \"cb19b77b8ff0799ec88b3307f38e7f70561f5107\", \"sql_unittests\": \"c04a7c3e07a787dccd7bb4d643081b0651660b2e\", \"ui_base_unittests\": \"ddbe212769d3f57b4097f4c736b6fadc3a005a8b\", \"url_unittests\": \"6f1a2995db2e88f0b9a409e29f3f3bf4a120f508\"}, \"xcode_build_version\": \"12d4e\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"ToTiOS\", \"ToTiOSDevice\"], \"caches\": [\"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_12d4e\"], \"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\", \"2.7\", \"2.7.16\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**ios_chrome_unittests_iPhone 6S 12.3.1** failed because of:\\n\\n- SharingCoordinatorTest.Start_ShareCurrentPage\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616341602053864",
"status": "COMPLETED",
"status_changed_ts": "1616341602519811",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/21755",
"builder:ToTiOSDevice",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1a9dec29bf7faeef5ad1be2592dd64bb864d64c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017566947758106096",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852136885776991328/+/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:526e46769a7f8310",
"user_agent:luci-scheduler"
],
"updated_ts": "1616358245165443",
"url": "https://ci.chromium.org/b/8852136885776991328",
"utcnow_ts": "1616358245748274"
}
}
[20:24:05.757] Invocation finished in 4h40m18.100487061s with status FAILED