[22:36:30.558] New invocation is queued and will start shortly
[22:36:32.129] Starting the invocation (attempt 1)
[22:36:32.169] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:36:32.169] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:36:32.169] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077334979815674256",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"037434aef224f6797d57e0f8e329f1616284bc19\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9077334979815674256",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/037434aef224f6797d57e0f8e329f1616284bc19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/037434aef224f6797d57e0f8e329f1616284bc19",
"gitiles_ref:refs/heads/master"
]
}
[22:36:33.550] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559342192572211",
"id": "8911904917039977856",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"037434aef224f6797d57e0f8e329f1616284bc19\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559342193402708",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7972",
"builder:ToTiOS",
"buildset:commit/git/037434aef224f6797d57e0f8e329f1616284bc19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/037434aef224f6797d57e0f8e329f1616284bc19",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077334979815674256",
"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/8911904917039977856/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1559342193402804",
"url": "https://ci.chromium.org/b/8911904917039977856",
"utcnow_ts": "1559342193540120"
}
}
[22:36:33.550] Task URL: https://ci.chromium.org/b/8911904917039977856
[22:36:33.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:2:0) after 1m0s
[22:37:33.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:2:0)
[22:37:33.980] Timer tick, asking Buildbucket for the build status
[22:37:34.144] Build 8911904917039977856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:34.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:3:0) after 1m0s
[22:37:40.332] Received PubSub notification, asking Buildbucket for the build status
[22:37:41.354] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:34.170] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:3:0)
[22:38:34.170] Timer tick, asking Buildbucket for the build status
[22:38:35.236] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:35.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:5:0) after 1m0s
[22:39:35.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:5:0)
[22:39:35.307] Timer tick, asking Buildbucket for the build status
[22:39:35.407] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:35.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:6:0) after 1m0s
[22:40:35.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:6:0)
[22:40:35.419] Timer tick, asking Buildbucket for the build status
[22:40:35.794] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:35.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:7:0) after 1m0s
[22:41:35.865] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:7:0)
[22:41:35.865] Timer tick, asking Buildbucket for the build status
[22:41:36.870] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:36.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:8:0) after 1m0s
[22:42:37.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:8:0)
[22:42:37.043] Timer tick, asking Buildbucket for the build status
[22:42:37.288] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:37.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:9:0) after 1m0s
[22:43:37.264] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:9:0)
[22:43:37.264] Timer tick, asking Buildbucket for the build status
[22:43:37.415] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:37.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:10:0) after 1m0s
[22:44:37.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:10:0)
[22:44:37.447] Timer tick, asking Buildbucket for the build status
[22:44:37.552] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:37.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:11:0) after 1m0s
[22:45:38.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:11:0)
[22:45:38.432] Timer tick, asking Buildbucket for the build status
[22:45:38.608] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:38.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:12:0) after 1m0s
[22:46:38.631] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:12:0)
[22:46:38.631] Timer tick, asking Buildbucket for the build status
[22:46:38.708] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:38.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:13:0) after 1m0s
[22:47:38.712] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:13:0)
[22:47:38.712] Timer tick, asking Buildbucket for the build status
[22:47:39.195] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:39.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:14:0) after 1m0s
[22:48:39.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:14:0)
[22:48:39.233] Timer tick, asking Buildbucket for the build status
[22:48:39.355] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:39.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:15:0) after 1m0s
[22:49:39.374] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:15:0)
[22:49:39.374] Timer tick, asking Buildbucket for the build status
[22:49:40.362] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:40.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:16:0) after 1m0s
[22:50:40.425] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:16:0)
[22:50:40.425] Timer tick, asking Buildbucket for the build status
[22:50:40.968] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:40.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:17:0) after 1m0s
[22:51:41.046] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:17:0)
[22:51:41.046] Timer tick, asking Buildbucket for the build status
[22:51:41.297] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:41.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:18:0) after 1m0s
[22:52:41.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:18:0)
[22:52:41.447] Timer tick, asking Buildbucket for the build status
[22:52:43.045] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:43.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:19:0) after 1m0s
[22:53:43.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:19:0)
[22:53:43.115] Timer tick, asking Buildbucket for the build status
[22:53:45.262] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:45.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:20:0) after 1m0s
[22:54:45.286] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:20:0)
[22:54:45.286] Timer tick, asking Buildbucket for the build status
[22:54:45.449] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:45.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:21:0) after 1m0s
[22:55:45.559] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:21:0)
[22:55:45.559] Timer tick, asking Buildbucket for the build status
[22:55:45.675] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:45.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:22:0) after 1m0s
[22:56:46.012] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:22:0)
[22:56:46.012] Timer tick, asking Buildbucket for the build status
[22:56:46.167] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:46.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:23:0) after 1m0s
[22:57:46.189] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:23:0)
[22:57:46.189] Timer tick, asking Buildbucket for the build status
[22:57:46.526] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:46.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:24:0) after 1m0s
[22:58:46.660] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:24:0)
[22:58:46.660] Timer tick, asking Buildbucket for the build status
[22:58:46.943] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:46.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:25:0) after 1m0s
[22:59:48.966] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:25:0)
[22:59:48.966] Timer tick, asking Buildbucket for the build status
[22:59:49.200] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:49.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:26:0) after 1m0s
[23:00:49.276] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:26:0)
[23:00:49.276] Timer tick, asking Buildbucket for the build status
[23:00:49.744] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:49.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:27:0) after 1m0s
[23:01:49.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:27:0)
[23:01:49.772] Timer tick, asking Buildbucket for the build status
[23:01:49.900] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:49.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:28:0) after 1m0s
[23:02:49.913] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:28:0)
[23:02:49.913] Timer tick, asking Buildbucket for the build status
[23:02:50.521] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:50.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:29:0) after 1m0s
[23:03:50.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:29:0)
[23:03:50.580] Timer tick, asking Buildbucket for the build status
[23:03:50.871] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:50.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:30:0) after 1m0s
[23:04:50.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:30:0)
[23:04:50.920] Timer tick, asking Buildbucket for the build status
[23:04:51.229] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:51.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:31:0) after 1m0s
[23:05:51.374] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:31:0)
[23:05:51.374] Timer tick, asking Buildbucket for the build status
[23:05:51.486] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:51.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:32:0) after 1m0s
[23:06:51.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:32:0)
[23:06:51.523] Timer tick, asking Buildbucket for the build status
[23:06:52.868] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:52.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:33:0) after 1m0s
[23:07:52.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:33:0)
[23:07:52.861] Timer tick, asking Buildbucket for the build status
[23:07:53.364] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:53.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:34:0) after 1m0s
[23:08:53.410] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:34:0)
[23:08:53.410] Timer tick, asking Buildbucket for the build status
[23:08:54.467] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:54.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:35:0) after 1m0s
[23:09:54.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:35:0)
[23:09:54.508] Timer tick, asking Buildbucket for the build status
[23:09:55.790] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:55.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:36:0) after 1m0s
[23:10:55.884] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:36:0)
[23:10:55.884] Timer tick, asking Buildbucket for the build status
[23:10:57.632] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:57.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:37:0) after 1m0s
[23:11:57.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:37:0)
[23:11:57.759] Timer tick, asking Buildbucket for the build status
[23:11:57.931] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:57.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:38:0) after 1m0s
[23:12:57.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:38:0)
[23:12:57.950] Timer tick, asking Buildbucket for the build status
[23:12:58.247] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:58.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:39:0) after 1m0s
[23:13:58.268] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:39:0)
[23:13:58.268] Timer tick, asking Buildbucket for the build status
[23:13:58.380] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:58.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:40:0) after 1m0s
[23:14:58.362] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:40:0)
[23:14:58.362] Timer tick, asking Buildbucket for the build status
[23:14:58.483] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:58.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:41:0) after 1m0s
[23:15:58.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:41:0)
[23:15:58.537] Timer tick, asking Buildbucket for the build status
[23:15:59.199] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:59.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:42:0) after 1m0s
[23:16:59.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:42:0)
[23:16:59.241] Timer tick, asking Buildbucket for the build status
[23:16:59.365] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:59.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:43:0) after 1m0s
[23:17:59.435] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:43:0)
[23:17:59.435] Timer tick, asking Buildbucket for the build status
[23:17:59.547] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:59.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:44:0) after 1m0s
[23:18:59.573] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:44:0)
[23:18:59.573] Timer tick, asking Buildbucket for the build status
[23:18:59.840] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:59.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:45:0) after 1m0s
[23:19:59.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:45:0)
[23:19:59.861] Timer tick, asking Buildbucket for the build status
[23:20:01.008] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:01.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:46:0) after 1m0s
[23:21:01.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:46:0)
[23:21:01.062] Timer tick, asking Buildbucket for the build status
[23:21:01.355] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:01.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:47:0) after 1m0s
[23:22:01.452] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:47:0)
[23:22:01.452] Timer tick, asking Buildbucket for the build status
[23:22:01.802] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:01.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:48:0) after 1m0s
[23:23:01.875] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:48:0)
[23:23:01.875] Timer tick, asking Buildbucket for the build status
[23:23:01.956] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:01.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:49:0) after 1m0s
[23:24:01.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:49:0)
[23:24:01.983] Timer tick, asking Buildbucket for the build status
[23:24:02.321] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:02.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:50:0) after 1m0s
[23:25:02.382] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:50:0)
[23:25:02.382] Timer tick, asking Buildbucket for the build status
[23:25:02.704] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:02.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:51:0) after 1m0s
[23:26:02.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:51:0)
[23:26:02.728] Timer tick, asking Buildbucket for the build status
[23:26:03.262] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:03.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:52:0) after 1m0s
[23:27:03.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:52:0)
[23:27:03.387] Timer tick, asking Buildbucket for the build status
[23:27:05.618] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:05.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:53:0) after 1m0s
[23:28:05.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:53:0)
[23:28:05.655] Timer tick, asking Buildbucket for the build status
[23:28:06.331] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:06.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:54:0) after 1m0s
[23:29:06.327] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:54:0)
[23:29:06.327] Timer tick, asking Buildbucket for the build status
[23:29:06.730] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:06.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:55:0) after 1m0s
[23:30:07.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:55:0)
[23:30:07.905] Timer tick, asking Buildbucket for the build status
[23:30:08.003] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:08.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:56:0) after 1m0s
[23:31:08.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:56:0)
[23:31:08.078] Timer tick, asking Buildbucket for the build status
[23:31:08.196] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:08.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:57:0) after 1m0s
[23:32:08.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:57:0)
[23:32:08.231] Timer tick, asking Buildbucket for the build status
[23:32:08.599] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:08.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:58:0) after 1m0s
[23:33:08.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:58:0)
[23:33:08.591] Timer tick, asking Buildbucket for the build status
[23:33:09.321] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:09.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:59:0) after 1m0s
[23:34:09.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:59:0)
[23:34:09.356] Timer tick, asking Buildbucket for the build status
[23:34:09.487] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:09.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:60:0) after 1m0s
[23:35:09.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:60:0)
[23:35:09.552] Timer tick, asking Buildbucket for the build status
[23:35:09.682] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:09.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:61:0) after 1m0s
[23:36:09.735] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:61:0)
[23:36:09.735] Timer tick, asking Buildbucket for the build status
[23:36:10.022] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:10.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:62:0) after 1m0s
[23:37:10.045] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:62:0)
[23:37:10.045] Timer tick, asking Buildbucket for the build status
[23:37:10.279] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:10.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:63:0) after 1m0s
[23:38:10.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:63:0)
[23:38:10.333] Timer tick, asking Buildbucket for the build status
[23:38:10.538] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:10.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:64:0) after 1m0s
[23:39:10.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:64:0)
[23:39:10.562] Timer tick, asking Buildbucket for the build status
[23:39:10.973] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:10.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:65:0) after 1m0s
[23:40:10.986] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:65:0)
[23:40:10.986] Timer tick, asking Buildbucket for the build status
[23:40:11.165] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:11.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:66:0) after 1m0s
[23:41:11.204] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:66:0)
[23:41:11.204] Timer tick, asking Buildbucket for the build status
[23:41:11.314] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:11.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:67:0) after 1m0s
[23:42:11.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:67:0)
[23:42:11.345] Timer tick, asking Buildbucket for the build status
[23:42:11.901] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:11.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:68:0) after 1m0s
[23:43:12.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:68:0)
[23:43:12.029] Timer tick, asking Buildbucket for the build status
[23:43:12.268] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:12.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:69:0) after 1m0s
[23:44:12.288] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:69:0)
[23:44:12.288] Timer tick, asking Buildbucket for the build status
[23:44:12.420] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:12.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:70:0) after 1m0s
[23:45:12.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:70:0)
[23:45:12.481] Timer tick, asking Buildbucket for the build status
[23:45:12.861] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:12.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:71:0) after 1m0s
[23:46:12.893] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:71:0)
[23:46:12.893] Timer tick, asking Buildbucket for the build status
[23:46:12.988] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:12.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:72:0) after 1m0s
[23:47:13.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:72:0)
[23:47:13.028] Timer tick, asking Buildbucket for the build status
[23:47:13.176] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:13.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:73:0) after 1m0s
[23:48:13.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:73:0)
[23:48:13.252] Timer tick, asking Buildbucket for the build status
[23:48:13.539] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:13.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:74:0) after 1m0s
[23:49:13.514] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:74:0)
[23:49:13.514] Timer tick, asking Buildbucket for the build status
[23:49:13.967] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:13.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:75:0) after 1m0s
[23:50:14.089] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:75:0)
[23:50:14.089] Timer tick, asking Buildbucket for the build status
[23:50:14.717] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:14.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:76:0) after 1m0s
[23:51:14.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:76:0)
[23:51:14.745] Timer tick, asking Buildbucket for the build status
[23:51:15.273] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:15.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:77:0) after 1m0s
[23:52:15.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:77:0)
[23:52:15.253] Timer tick, asking Buildbucket for the build status
[23:52:15.846] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:15.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:78:0) after 1m0s
[23:53:15.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:78:0)
[23:53:15.866] Timer tick, asking Buildbucket for the build status
[23:53:16.963] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:16.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:79:0) after 1m0s
[23:54:17.012] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:79:0)
[23:54:17.012] Timer tick, asking Buildbucket for the build status
[23:54:17.446] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:17.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:80:0) after 1m0s
[23:55:17.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:80:0)
[23:55:17.485] Timer tick, asking Buildbucket for the build status
[23:55:17.605] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:17.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:81:0) after 1m0s
[23:56:17.647] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:81:0)
[23:56:17.647] Timer tick, asking Buildbucket for the build status
[23:56:17.940] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:17.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:82:0) after 1m0s
[23:57:17.973] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:82:0)
[23:57:17.973] Timer tick, asking Buildbucket for the build status
[23:57:18.660] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:18.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:83:0) after 1m0s
[23:58:18.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:83:0)
[23:58:18.749] Timer tick, asking Buildbucket for the build status
[23:58:18.864] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:18.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:84:0) after 1m0s
[23:59:18.894] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:84:0)
[23:59:18.894] Timer tick, asking Buildbucket for the build status
[23:59:19.384] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:19.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:85:0) after 1m0s
[00:00:19.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:85:0)
[00:00:19.406] Timer tick, asking Buildbucket for the build status
[00:00:19.507] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:19.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:86:0) after 1m0s
[00:01:19.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:86:0)
[00:01:19.644] Timer tick, asking Buildbucket for the build status
[00:01:19.792] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:19.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:87:0) after 1m0s
[00:02:19.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:87:0)
[00:02:19.874] Timer tick, asking Buildbucket for the build status
[00:02:20.096] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:20.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:88:0) after 1m0s
[00:03:20.086] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:88:0)
[00:03:20.086] Timer tick, asking Buildbucket for the build status
[00:03:20.264] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:20.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:89:0) after 1m0s
[00:04:20.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:89:0)
[00:04:20.324] Timer tick, asking Buildbucket for the build status
[00:04:20.421] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:20.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:90:0) after 1m0s
[00:05:20.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:90:0)
[00:05:20.450] Timer tick, asking Buildbucket for the build status
[00:05:20.674] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:20.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:91:0) after 1m0s
[00:06:20.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:91:0)
[00:06:20.705] Timer tick, asking Buildbucket for the build status
[00:06:20.957] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:20.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:92:0) after 1m0s
[00:07:21.012] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:92:0)
[00:07:21.012] Timer tick, asking Buildbucket for the build status
[00:07:21.999] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:21.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:93:0) after 1m0s
[00:08:22.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:93:0)
[00:08:22.035] Timer tick, asking Buildbucket for the build status
[00:08:22.494] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:22.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:94:0) after 1m0s
[00:09:22.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:94:0)
[00:09:22.738] Timer tick, asking Buildbucket for the build status
[00:09:22.990] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:22.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:95:0) after 1m0s
[00:10:23.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:95:0)
[00:10:23.015] Timer tick, asking Buildbucket for the build status
[00:10:25.680] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:25.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:96:0) after 1m0s
[00:11:25.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:96:0)
[00:11:25.900] Timer tick, asking Buildbucket for the build status
[00:11:26.848] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:26.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:97:0) after 1m0s
[00:12:47.415] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:97:0)
[00:12:47.416] Timer tick, asking Buildbucket for the build status
[00:12:47.941] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:47.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:98:0) after 1m0s
[00:13:48.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:98:0)
[00:13:48.015] Timer tick, asking Buildbucket for the build status
[00:13:48.941] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:48.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:99:0) after 1m0s
[00:14:49.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:99:0)
[00:14:49.259] Timer tick, asking Buildbucket for the build status
[00:14:49.599] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:49.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:100:0) after 1m0s
[00:15:50.072] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:100:0)
[00:15:50.072] Timer tick, asking Buildbucket for the build status
[00:15:50.267] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:50.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:101:0) after 1m0s
[00:16:50.476] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:101:0)
[00:16:50.476] Timer tick, asking Buildbucket for the build status
[00:16:50.811] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:50.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:102:0) after 1m0s
[00:17:50.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:102:0)
[00:17:50.833] Timer tick, asking Buildbucket for the build status
[00:17:51.054] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:51.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:103:0) after 1m0s
[00:18:51.109] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:103:0)
[00:18:51.109] Timer tick, asking Buildbucket for the build status
[00:18:51.613] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:51.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:104:0) after 1m0s
[00:19:51.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:104:0)
[00:19:51.644] Timer tick, asking Buildbucket for the build status
[00:19:52.179] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:52.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:105:0) after 1m0s
[00:20:55.455] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:105:0)
[00:20:55.455] Timer tick, asking Buildbucket for the build status
[00:20:58.873] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:58.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:106:0) after 1m0s
[00:21:58.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:106:0)
[00:21:58.942] Timer tick, asking Buildbucket for the build status
[00:22:00.028] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:00.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:107:0) after 1m0s
[00:23:00.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:107:0)
[00:23:00.122] Timer tick, asking Buildbucket for the build status
[00:23:00.345] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:00.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:108:0) after 1m0s
[00:24:00.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:108:0)
[00:24:00.385] Timer tick, asking Buildbucket for the build status
[00:24:01.957] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:01.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:109:0) after 1m0s
[00:25:02.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:109:0)
[00:25:02.037] Timer tick, asking Buildbucket for the build status
[00:25:02.330] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:02.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:110:0) after 1m0s
[00:26:02.365] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:110:0)
[00:26:02.365] Timer tick, asking Buildbucket for the build status
[00:26:02.979] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:02.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:111:0) after 1m0s
[00:27:03.084] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:111:0)
[00:27:03.084] Timer tick, asking Buildbucket for the build status
[00:27:03.302] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:03.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:112:0) after 1m0s
[00:28:04.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:112:0)
[00:28:04.543] Timer tick, asking Buildbucket for the build status
[00:28:06.648] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:06.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:113:0) after 1m0s
[00:29:06.928] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:113:0)
[00:29:06.928] Timer tick, asking Buildbucket for the build status
[00:29:07.181] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:07.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:114:0) after 1m0s
[00:30:07.594] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:114:0)
[00:30:07.594] Timer tick, asking Buildbucket for the build status
[00:30:08.804] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:08.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:115:0) after 1m0s
[00:31:09.147] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:115:0)
[00:31:09.147] Timer tick, asking Buildbucket for the build status
[00:31:13.451] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:13.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:116:0) after 1m0s
[00:32:13.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:116:0)
[00:32:13.652] Timer tick, asking Buildbucket for the build status
[00:32:14.151] Build 8911904917039977856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:14.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077334979815674256:117:0) after 1m0s
[00:32:56.894] Received PubSub notification, asking Buildbucket for the build status
[00:32:57.065] Build 8911904917039977856: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:32:57.065] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559349174980196",
"created_by": "project:chromium",
"created_ts": "1559342192572211",
"id": "8911904917039977856",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"037434aef224f6797d57e0f8e329f1616284bc19\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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\": \"build285-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 7972, \"got_angle_revision\": \"cc9bc65588ee10832316de8fb1dd55505ac6e417\", \"got_dawn_revision\": \"839053b90c7718b9162a123ce040117d2d223cc3\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"037434aef224f6797d57e0f8e329f1616284bc19\", \"got_revision_cp\": \"refs/heads/master@{#665309}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"2cb25737c9eb7893ac752674e75d400b4419f67c\", \"got_v8_revision_cp\": \"refs/heads/7.6.303@{#1}\", \"got_webrtc_revision\": \"85b8ce2ab95bea71bebd5238f86df04183ac4025\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28124}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"037434aef224f6797d57e0f8e329f1616284bc19\", \"swarm_hashes\": {\"0\": \"9ea7d65903befa87f937ec5cde6f0f21e0e93f7a\", \"1\": \"9bb7bd406dd2ad1751440a40352d2c53fe84af1f\", \"10\": \"881baaf9660f4156555c3897f603d39ac5cd34bc\", \"11\": \"296c0c1b463f1ac6b3fbd3eb86ec086f9236db79\", \"12\": \"36942606247c486ab55f240155b90ab27cff57b3\", \"13\": \"41988b432cf0adb58efcda8ee45bd26d385b2ce6\", \"14\": \"caef170605b557d5c6d26c60c5fe0ead51d54b94\", \"15\": \"882aa344bb4a5f213ac93e36e85281eb76d3ab46\", \"16\": \"372878e1553f784217491f09f0ed8f5f8f465c97\", \"2\": \"e434b08af53274bc1ca51baa47b4d5e01bb19311\", \"3\": \"2abea6f5c5afba5bd677051310c136748373acbd\", \"4\": \"31fdb88b5523b17b1b7f49efcd88b92c59534d74\", \"5\": \"9f74d32f8502a69c2b49b93b8cd67e633cd95dd0\", \"6\": \"89e60df12fbf83b9db0434e233de7c2d25f93702\", \"7\": \"7a423d2968c20c43db1c94ca36b5037101985f1a\", \"8\": \"f5363967524f4fba4351a7c95c8832b7e70a12e6\", \"9\": \"4a504b3dd6e8cc18d7a205c37a046624b0b8adb9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"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\": [\"build285-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4316-effbcfc\"], \"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": "1559342259647280",
"status": "COMPLETED",
"status_changed_ts": "1559349176183740",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7972",
"builder:ToTiOS",
"buildset:commit/git/037434aef224f6797d57e0f8e329f1616284bc19",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/037434aef224f6797d57e0f8e329f1616284bc19",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077334979815674256",
"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/8911904917039977856/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4528db247b35c910",
"user_agent:luci-scheduler"
],
"updated_ts": "1559349176186326",
"url": "https://ci.chromium.org/b/8911904917039977856",
"utcnow_ts": "1559349177034537"
}
}
[00:32:57.065] Invocation finished in 1h56m26.523951027s with status SUCCEEDED