[15:37:04.284] New invocation is queued and will start shortly
[15:37:05.495] Starting the invocation (attempt 1)
[15:37:05.541] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:37:05.541] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:37:05.541] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9046830190893532272",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b5c8f2119351e7efd0b4ee0e3a43918640081edb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9046830190893532272",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/b5c8f2119351e7efd0b4ee0e3a43918640081edb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5c8f2119351e7efd0b4ee0e3a43918640081edb",
"gitiles_ref:refs/heads/master"
]
}
[15:37:06.458] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1588433825647860",
"id": "8881400128796543024",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b5c8f2119351e7efd0b4ee0e3a43918640081edb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1588433826285765",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/13920",
"builder:ToTiOS",
"buildset:commit/git/b5c8f2119351e7efd0b4ee0e3a43918640081edb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5c8f2119351e7efd0b4ee0e3a43918640081edb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046830190893532272",
"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/8881400128796543024/+/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": "1588433826285882",
"url": "https://ci.chromium.org/b/8881400128796543024",
"utcnow_ts": "1588433826446005"
}
}
[15:37:06.458] Task URL: https://ci.chromium.org/b/8881400128796543024
[15:37:06.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:2:0) after 1m0s
[15:37:10.930] Received PubSub notification, asking Buildbucket for the build status
[15:37:11.011] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:06.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:2:0)
[15:38:06.463] Timer tick, asking Buildbucket for the build status
[15:38:06.631] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:06.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:4:0) after 1m0s
[15:39:06.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:4:0)
[15:39:06.717] Timer tick, asking Buildbucket for the build status
[15:39:06.833] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:06.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:5:0) after 1m0s
[15:40:06.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:5:0)
[15:40:06.925] Timer tick, asking Buildbucket for the build status
[15:40:07.054] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:07.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:6:0) after 1m0s
[15:41:07.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:6:0)
[15:41:07.145] Timer tick, asking Buildbucket for the build status
[15:41:07.273] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:07.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:7:0) after 1m0s
[15:42:07.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:7:0)
[15:42:07.308] Timer tick, asking Buildbucket for the build status
[15:42:07.562] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:07.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:8:0) after 1m0s
[15:43:07.587] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:8:0)
[15:43:07.587] Timer tick, asking Buildbucket for the build status
[15:43:07.736] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:07.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:9:0) after 1m0s
[15:44:07.858] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:9:0)
[15:44:07.858] Timer tick, asking Buildbucket for the build status
[15:44:08.016] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:08.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:10:0) after 1m0s
[15:45:08.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:10:0)
[15:45:08.132] Timer tick, asking Buildbucket for the build status
[15:45:08.289] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:08.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:11:0) after 1m0s
[15:46:08.352] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:11:0)
[15:46:08.352] Timer tick, asking Buildbucket for the build status
[15:46:08.573] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:08.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:12:0) after 1m0s
[15:47:08.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:12:0)
[15:47:08.602] Timer tick, asking Buildbucket for the build status
[15:47:08.745] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:08.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:13:0) after 1m0s
[15:48:08.786] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:13:0)
[15:48:08.786] Timer tick, asking Buildbucket for the build status
[15:48:08.876] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:08.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:14:0) after 1m0s
[15:49:08.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:14:0)
[15:49:08.901] Timer tick, asking Buildbucket for the build status
[15:49:09.012] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:09.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:15:0) after 1m0s
[15:50:08.990] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:15:0)
[15:50:08.990] Timer tick, asking Buildbucket for the build status
[15:50:09.175] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:09.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:16:0) after 1m0s
[15:51:09.185] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:16:0)
[15:51:09.185] Timer tick, asking Buildbucket for the build status
[15:51:09.345] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:09.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:17:0) after 1m0s
[15:52:09.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:17:0)
[15:52:09.380] Timer tick, asking Buildbucket for the build status
[15:52:09.495] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:09.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:18:0) after 1m0s
[15:53:09.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:18:0)
[15:53:09.523] Timer tick, asking Buildbucket for the build status
[15:53:09.849] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:09.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:19:0) after 1m0s
[15:54:09.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:19:0)
[15:54:09.874] Timer tick, asking Buildbucket for the build status
[15:54:10.014] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:10.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:20:0) after 1m0s
[15:55:10.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:20:0)
[15:55:10.058] Timer tick, asking Buildbucket for the build status
[15:55:10.170] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:10.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:21:0) after 1m0s
[15:56:10.222] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:21:0)
[15:56:10.222] Timer tick, asking Buildbucket for the build status
[15:56:10.382] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:10.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:22:0) after 1m0s
[15:57:10.436] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:22:0)
[15:57:10.436] Timer tick, asking Buildbucket for the build status
[15:57:10.671] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:10.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:23:0) after 1m0s
[15:58:10.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:23:0)
[15:58:10.720] Timer tick, asking Buildbucket for the build status
[15:58:10.878] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:10.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:24:0) after 1m0s
[15:59:10.989] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:24:0)
[15:59:10.989] Timer tick, asking Buildbucket for the build status
[15:59:11.164] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:11.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:25:0) after 1m0s
[16:00:11.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:25:0)
[16:00:11.252] Timer tick, asking Buildbucket for the build status
[16:00:11.462] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:11.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:26:0) after 1m0s
[16:01:11.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:26:0)
[16:01:11.566] Timer tick, asking Buildbucket for the build status
[16:01:11.717] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:11.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:27:0) after 1m0s
[16:02:11.755] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:27:0)
[16:02:11.755] Timer tick, asking Buildbucket for the build status
[16:02:12.041] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:12.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:28:0) after 1m0s
[16:03:12.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:28:0)
[16:03:12.065] Timer tick, asking Buildbucket for the build status
[16:03:12.301] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:12.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:29:0) after 1m0s
[16:04:12.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:29:0)
[16:04:12.300] Timer tick, asking Buildbucket for the build status
[16:04:12.474] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:12.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:30:0) after 1m0s
[16:05:12.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:30:0)
[16:05:12.538] Timer tick, asking Buildbucket for the build status
[16:05:12.743] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:12.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:31:0) after 1m0s
[16:06:12.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:31:0)
[16:06:12.773] Timer tick, asking Buildbucket for the build status
[16:06:13.542] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:13.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:32:0) after 1m0s
[16:07:13.585] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:32:0)
[16:07:13.585] Timer tick, asking Buildbucket for the build status
[16:07:13.701] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:13.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:33:0) after 1m0s
[16:08:13.752] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:33:0)
[16:08:13.752] Timer tick, asking Buildbucket for the build status
[16:08:13.857] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:13.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:34:0) after 1m0s
[16:09:13.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:34:0)
[16:09:13.950] Timer tick, asking Buildbucket for the build status
[16:09:14.595] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:14.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:35:0) after 1m0s
[16:10:14.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:35:0)
[16:10:14.664] Timer tick, asking Buildbucket for the build status
[16:10:14.987] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:14.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:36:0) after 1m0s
[16:11:15.054] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:36:0)
[16:11:15.054] Timer tick, asking Buildbucket for the build status
[16:11:15.196] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:15.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:37:0) after 1m0s
[16:12:15.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:37:0)
[16:12:15.225] Timer tick, asking Buildbucket for the build status
[16:12:15.382] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:15.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:38:0) after 1m0s
[16:13:15.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:38:0)
[16:13:15.405] Timer tick, asking Buildbucket for the build status
[16:13:15.644] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:15.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:39:0) after 1m0s
[16:14:15.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:39:0)
[16:14:15.787] Timer tick, asking Buildbucket for the build status
[16:14:15.894] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:15.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:40:0) after 1m0s
[16:15:15.989] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:40:0)
[16:15:15.989] Timer tick, asking Buildbucket for the build status
[16:15:16.352] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:16.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:41:0) after 1m0s
[16:16:16.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:41:0)
[16:16:16.494] Timer tick, asking Buildbucket for the build status
[16:16:16.887] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:16.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:42:0) after 1m0s
[16:17:16.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:42:0)
[16:17:16.950] Timer tick, asking Buildbucket for the build status
[16:17:17.912] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:17.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:43:0) after 1m0s
[16:18:17.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:43:0)
[16:18:17.967] Timer tick, asking Buildbucket for the build status
[16:18:18.335] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:18.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:44:0) after 1m0s
[16:19:18.365] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:44:0)
[16:19:18.365] Timer tick, asking Buildbucket for the build status
[16:19:18.528] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:18.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:45:0) after 1m0s
[16:20:18.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:45:0)
[16:20:18.572] Timer tick, asking Buildbucket for the build status
[16:20:18.986] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:18.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:46:0) after 1m0s
[16:21:18.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:46:0)
[16:21:18.998] Timer tick, asking Buildbucket for the build status
[16:21:19.148] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:19.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:47:0) after 1m0s
[16:22:19.219] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:47:0)
[16:22:19.219] Timer tick, asking Buildbucket for the build status
[16:22:19.328] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:19.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:48:0) after 1m0s
[16:23:19.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:48:0)
[16:23:19.380] Timer tick, asking Buildbucket for the build status
[16:23:19.468] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:19.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:49:0) after 1m0s
[16:24:19.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:49:0)
[16:24:19.542] Timer tick, asking Buildbucket for the build status
[16:24:19.732] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:19.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:50:0) after 1m0s
[16:25:20.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:50:0)
[16:25:20.055] Timer tick, asking Buildbucket for the build status
[16:25:20.177] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:20.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:51:0) after 1m0s
[16:26:20.351] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:51:0)
[16:26:20.351] Timer tick, asking Buildbucket for the build status
[16:26:20.563] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:20.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:52:0) after 1m0s
[16:27:20.774] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:52:0)
[16:27:20.774] Timer tick, asking Buildbucket for the build status
[16:27:20.984] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:20.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:53:0) after 1m0s
[16:28:21.149] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:53:0)
[16:28:21.149] Timer tick, asking Buildbucket for the build status
[16:28:21.264] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:21.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:54:0) after 1m0s
[16:29:21.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:54:0)
[16:29:21.293] Timer tick, asking Buildbucket for the build status
[16:29:21.486] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:21.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:55:0) after 1m0s
[16:30:21.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:55:0)
[16:30:21.574] Timer tick, asking Buildbucket for the build status
[16:30:21.703] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:21.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:56:0) after 1m0s
[16:31:21.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:56:0)
[16:31:21.778] Timer tick, asking Buildbucket for the build status
[16:31:21.983] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:21.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:57:0) after 1m0s
[16:32:22.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:57:0)
[16:32:22.103] Timer tick, asking Buildbucket for the build status
[16:32:22.361] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:22.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:58:0) after 1m0s
[16:33:22.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:58:0)
[16:33:22.508] Timer tick, asking Buildbucket for the build status
[16:33:22.638] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:22.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:59:0) after 1m0s
[16:34:22.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:59:0)
[16:34:22.717] Timer tick, asking Buildbucket for the build status
[16:34:22.832] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:22.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:60:0) after 1m0s
[16:35:22.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:60:0)
[16:35:22.818] Timer tick, asking Buildbucket for the build status
[16:35:22.983] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:22.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:61:0) after 1m0s
[16:36:23.032] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:61:0)
[16:36:23.032] Timer tick, asking Buildbucket for the build status
[16:36:23.173] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:23.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:62:0) after 1m0s
[16:37:23.202] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:62:0)
[16:37:23.203] Timer tick, asking Buildbucket for the build status
[16:37:23.348] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:23.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:63:0) after 1m0s
[16:38:23.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:63:0)
[16:38:23.421] Timer tick, asking Buildbucket for the build status
[16:38:23.601] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:23.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:64:0) after 1m0s
[16:39:23.615] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:64:0)
[16:39:23.615] Timer tick, asking Buildbucket for the build status
[16:39:23.906] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:23.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:65:0) after 1m0s
[16:40:23.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:65:0)
[16:40:23.929] Timer tick, asking Buildbucket for the build status
[16:40:24.257] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:24.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:66:0) after 1m0s
[16:41:24.284] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:66:0)
[16:41:24.284] Timer tick, asking Buildbucket for the build status
[16:41:25.136] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:25.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:67:0) after 1m0s
[16:42:25.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:67:0)
[16:42:25.168] Timer tick, asking Buildbucket for the build status
[16:42:25.508] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:25.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:68:0) after 1m0s
[16:43:25.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:68:0)
[16:43:25.644] Timer tick, asking Buildbucket for the build status
[16:43:25.836] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:25.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:69:0) after 1m0s
[16:44:25.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:69:0)
[16:44:25.879] Timer tick, asking Buildbucket for the build status
[16:44:25.982] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:25.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:70:0) after 1m0s
[16:45:26.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:70:0)
[16:45:26.101] Timer tick, asking Buildbucket for the build status
[16:45:26.236] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:26.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:71:0) after 1m0s
[16:46:26.426] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:71:0)
[16:46:26.426] Timer tick, asking Buildbucket for the build status
[16:46:26.986] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:26.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:72:0) after 1m0s
[16:47:27.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:72:0)
[16:47:27.017] Timer tick, asking Buildbucket for the build status
[16:47:27.152] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:27.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:73:0) after 1m0s
[16:48:27.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:73:0)
[16:48:27.198] Timer tick, asking Buildbucket for the build status
[16:48:27.533] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:27.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:74:0) after 1m0s
[16:49:27.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:74:0)
[16:49:27.555] Timer tick, asking Buildbucket for the build status
[16:49:27.665] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:27.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:75:0) after 1m0s
[16:50:27.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:75:0)
[16:50:27.691] Timer tick, asking Buildbucket for the build status
[16:50:28.094] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:28.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:76:0) after 1m0s
[16:51:28.120] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:76:0)
[16:51:28.120] Timer tick, asking Buildbucket for the build status
[16:51:28.237] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:28.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:77:0) after 1m0s
[16:52:28.312] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:77:0)
[16:52:28.312] Timer tick, asking Buildbucket for the build status
[16:52:28.411] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:28.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:78:0) after 1m0s
[16:53:28.514] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:78:0)
[16:53:28.514] Timer tick, asking Buildbucket for the build status
[16:53:28.691] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:28.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:79:0) after 1m0s
[16:54:28.804] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:79:0)
[16:54:28.804] Timer tick, asking Buildbucket for the build status
[16:54:29.087] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:29.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:80:0) after 1m0s
[16:55:29.114] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:80:0)
[16:55:29.114] Timer tick, asking Buildbucket for the build status
[16:55:29.350] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:29.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:81:0) after 1m0s
[16:56:29.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:81:0)
[16:56:29.386] Timer tick, asking Buildbucket for the build status
[16:56:31.963] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:31.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:82:0) after 1m0s
[16:57:32.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:82:0)
[16:57:32.127] Timer tick, asking Buildbucket for the build status
[16:57:32.272] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:32.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:83:0) after 1m0s
[16:58:32.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:83:0)
[16:58:32.318] Timer tick, asking Buildbucket for the build status
[16:58:32.593] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:32.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:84:0) after 1m0s
[16:59:32.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:84:0)
[16:59:32.692] Timer tick, asking Buildbucket for the build status
[16:59:32.819] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:32.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:85:0) after 1m0s
[17:00:32.854] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:85:0)
[17:00:32.854] Timer tick, asking Buildbucket for the build status
[17:00:33.075] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:33.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:86:0) after 1m0s
[17:01:33.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:86:0)
[17:01:33.197] Timer tick, asking Buildbucket for the build status
[17:01:33.633] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:33.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:87:0) after 1m0s
[17:02:33.685] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:87:0)
[17:02:33.685] Timer tick, asking Buildbucket for the build status
[17:02:33.851] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:33.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:88:0) after 1m0s
[17:03:33.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:88:0)
[17:03:33.929] Timer tick, asking Buildbucket for the build status
[17:03:34.139] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:34.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:89:0) after 1m0s
[17:04:34.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:89:0)
[17:04:34.137] Timer tick, asking Buildbucket for the build status
[17:04:34.450] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:34.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:90:0) after 1m0s
[17:05:34.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:90:0)
[17:05:34.535] Timer tick, asking Buildbucket for the build status
[17:05:34.640] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:34.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:91:0) after 1m0s
[17:06:34.665] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:91:0)
[17:06:34.665] Timer tick, asking Buildbucket for the build status
[17:06:36.766] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:36.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:92:0) after 1m0s
[17:07:36.853] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:92:0)
[17:07:36.853] Timer tick, asking Buildbucket for the build status
[17:07:37.058] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:37.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:93:0) after 1m0s
[17:08:37.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:93:0)
[17:08:37.468] Timer tick, asking Buildbucket for the build status
[17:08:37.608] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:37.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:94:0) after 1m0s
[17:09:37.645] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:94:0)
[17:09:37.645] Timer tick, asking Buildbucket for the build status
[17:09:37.751] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:37.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:95:0) after 1m0s
[17:10:37.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:95:0)
[17:10:37.784] Timer tick, asking Buildbucket for the build status
[17:10:38.201] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:38.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:96:0) after 1m0s
[17:11:38.228] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:96:0)
[17:11:38.228] Timer tick, asking Buildbucket for the build status
[17:11:38.364] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:38.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:97:0) after 1m0s
[17:12:38.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:97:0)
[17:12:38.393] Timer tick, asking Buildbucket for the build status
[17:12:38.521] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:38.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:98:0) after 1m0s
[17:13:38.551] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:98:0)
[17:13:38.551] Timer tick, asking Buildbucket for the build status
[17:13:38.741] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:38.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:99:0) after 1m0s
[17:14:38.774] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:99:0)
[17:14:38.774] Timer tick, asking Buildbucket for the build status
[17:14:39.148] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:39.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:100:0) after 1m0s
[17:15:39.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:100:0)
[17:15:39.175] Timer tick, asking Buildbucket for the build status
[17:15:39.472] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:39.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:101:0) after 1m0s
[17:16:39.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:101:0)
[17:16:39.515] Timer tick, asking Buildbucket for the build status
[17:16:39.650] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:39.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:102:0) after 1m0s
[17:17:39.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:102:0)
[17:17:39.673] Timer tick, asking Buildbucket for the build status
[17:17:40.073] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:40.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:103:0) after 1m0s
[17:18:40.190] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:103:0)
[17:18:40.190] Timer tick, asking Buildbucket for the build status
[17:18:40.314] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:40.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:104:0) after 1m0s
[17:19:40.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:104:0)
[17:19:40.728] Timer tick, asking Buildbucket for the build status
[17:19:40.890] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:40.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:105:0) after 1m0s
[17:20:40.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:105:0)
[17:20:40.914] Timer tick, asking Buildbucket for the build status
[17:20:41.047] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:41.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:106:0) after 1m0s
[17:21:41.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:106:0)
[17:21:41.216] Timer tick, asking Buildbucket for the build status
[17:21:41.385] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:41.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:107:0) after 1m0s
[17:22:41.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:107:0)
[17:22:41.589] Timer tick, asking Buildbucket for the build status
[17:22:41.892] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:41.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:108:0) after 1m0s
[17:23:47.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:108:0)
[17:23:47.739] Timer tick, asking Buildbucket for the build status
[17:23:47.859] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:47.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:109:0) after 1m0s
[17:24:47.884] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:109:0)
[17:24:47.884] Timer tick, asking Buildbucket for the build status
[17:24:48.110] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:48.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:110:0) after 1m0s
[17:25:48.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:110:0)
[17:25:48.151] Timer tick, asking Buildbucket for the build status
[17:25:48.305] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:48.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:111:0) after 1m0s
[17:26:48.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:111:0)
[17:26:48.335] Timer tick, asking Buildbucket for the build status
[17:26:48.463] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:48.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:112:0) after 1m0s
[17:27:48.489] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:112:0)
[17:27:48.489] Timer tick, asking Buildbucket for the build status
[17:27:48.615] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:48.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:113:0) after 1m0s
[17:28:48.670] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:113:0)
[17:28:48.670] Timer tick, asking Buildbucket for the build status
[17:28:48.864] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:48.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:114:0) after 1m0s
[17:29:48.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:114:0)
[17:29:48.917] Timer tick, asking Buildbucket for the build status
[17:29:49.258] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:49.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:115:0) after 1m0s
[17:30:49.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:115:0)
[17:30:49.262] Timer tick, asking Buildbucket for the build status
[17:30:49.400] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:49.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:116:0) after 1m0s
[17:31:49.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:116:0)
[17:31:49.422] Timer tick, asking Buildbucket for the build status
[17:31:49.686] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:49.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:117:0) after 1m0s
[17:32:49.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:117:0)
[17:32:49.677] Timer tick, asking Buildbucket for the build status
[17:32:51.232] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:51.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:118:0) after 1m0s
[17:33:51.306] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:118:0)
[17:33:51.306] Timer tick, asking Buildbucket for the build status
[17:33:51.532] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:51.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:119:0) after 1m0s
[17:34:51.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:119:0)
[17:34:51.566] Timer tick, asking Buildbucket for the build status
[17:34:51.830] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:51.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:120:0) after 1m0s
[17:35:51.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:120:0)
[17:35:51.903] Timer tick, asking Buildbucket for the build status
[17:35:52.289] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:52.290] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:121:0) after 1m0s
[17:36:52.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:121:0)
[17:36:52.314] Timer tick, asking Buildbucket for the build status
[17:36:52.476] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:52.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:122:0) after 1m0s
[17:37:52.534] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:122:0)
[17:37:52.534] Timer tick, asking Buildbucket for the build status
[17:37:52.699] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:52.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:123:0) after 1m0s
[17:38:52.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:123:0)
[17:38:52.782] Timer tick, asking Buildbucket for the build status
[17:38:53.160] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:53.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:124:0) after 1m0s
[17:39:53.187] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:124:0)
[17:39:53.187] Timer tick, asking Buildbucket for the build status
[17:39:53.351] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:53.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:125:0) after 1m0s
[17:40:53.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:125:0)
[17:40:53.515] Timer tick, asking Buildbucket for the build status
[17:40:53.777] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:53.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:126:0) after 1m0s
[17:41:54.359] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:126:0)
[17:41:54.359] Timer tick, asking Buildbucket for the build status
[17:41:54.581] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:54.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:127:0) after 1m0s
[17:42:54.658] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:127:0)
[17:42:54.658] Timer tick, asking Buildbucket for the build status
[17:42:54.810] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:54.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:128:0) after 1m0s
[17:43:55.048] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:128:0)
[17:43:55.048] Timer tick, asking Buildbucket for the build status
[17:43:55.177] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:55.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:129:0) after 1m0s
[17:44:55.243] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:129:0)
[17:44:55.243] Timer tick, asking Buildbucket for the build status
[17:44:55.366] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:55.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:130:0) after 1m0s
[17:45:55.487] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:130:0)
[17:45:55.487] Timer tick, asking Buildbucket for the build status
[17:45:55.618] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:55.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:131:0) after 1m0s
[17:46:55.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:131:0)
[17:46:55.673] Timer tick, asking Buildbucket for the build status
[17:46:55.795] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:55.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:132:0) after 1m0s
[17:47:55.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:132:0)
[17:47:55.863] Timer tick, asking Buildbucket for the build status
[17:47:55.955] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:55.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:133:0) after 1m0s
[17:48:56.272] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:133:0)
[17:48:56.272] Timer tick, asking Buildbucket for the build status
[17:48:56.566] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:56.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:134:0) after 1m0s
[17:49:56.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:134:0)
[17:49:56.599] Timer tick, asking Buildbucket for the build status
[17:49:57.046] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:57.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:135:0) after 1m0s
[17:50:57.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:135:0)
[17:50:57.123] Timer tick, asking Buildbucket for the build status
[17:50:57.274] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:57.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:136:0) after 1m0s
[17:51:57.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:136:0)
[17:51:57.353] Timer tick, asking Buildbucket for the build status
[17:51:57.479] Build 8881400128796543024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:57.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046830190893532272:137:0) after 1m0s
[17:52:15.375] Received PubSub notification, asking Buildbucket for the build status
[17:52:15.450] Build 8881400128796543024: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:52:15.450] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1588441933930845",
"created_by": "project:chromium",
"created_ts": "1588433825647860",
"id": "8881400128796543024",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b5c8f2119351e7efd0b4ee0e3a43918640081edb\"}}",
"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\": \"build283-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 13920, \"got_angle_revision\": \"040e4f6fcf5428ff52f6c6cff19f8b3cb26e5eaf\", \"got_clang_revision\": \"n346557-4e0d9925-3\", \"got_dawn_revision\": \"303a3daf0decb8eaacb251346be317be00dda479\", \"got_nacl_revision\": \"08ef20f1933cc724a25911b4da99a9e7355cafa0\", \"got_revision\": \"b5c8f2119351e7efd0b4ee0e3a43918640081edb\", \"got_revision_cp\": \"refs/heads/master@{#764927}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"b798cfa374ebfaa04d08458b277f6c499a16b527\", \"got_v8_revision\": \"ffa14bc12c71f817f31eaeaa7dbe4c90871f67d6\", \"got_v8_revision_cp\": \"refs/heads/8.4.268@{#1}\", \"got_webrtc_revision\": \"3745d3fc9390fe6e8b1ab24d64820aa1402b47ae\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31148}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b5c8f2119351e7efd0b4ee0e3a43918640081edb\", \"swarm_hashes\": {\"base_unittests\": \"41c3eac7140f6ae145aca07e800ccd2bc9c7eac2\", \"boringssl_crypto_tests\": \"b76ffb653270c634da70751e74ce94bb00be7529\", \"boringssl_ssl_tests\": \"0d577b4b796d0cd637c67f4d8e95a3de70220c00\", \"components_unittests\": \"41809d22b8f9a59181fbedd5ff40b2da18dde9f2\", \"crypto_unittests\": \"f607563a8c29475f2585afc4cd36817fc60da034\", \"gfx_unittests\": \"d4a4a1084bd713a7e7fc8e099bda70b1f0f8b4f0\", \"google_apis_unittests\": \"497c217017c93235beae22aefbb66688e773bee0\", \"ios_chrome_unittests\": \"b62a1c92bbc4abd130d49acc8313c58f2e461b5b\", \"ios_net_unittests\": \"b6e46ff92e3875a0e5bcd8af0d45e14ef3230420\", \"ios_web_inttests\": \"f8e2c18aabfdf5f3004c3d4ad4f78e56d6a420ac\", \"ios_web_unittests\": \"4041b020739627bfb1847ad7740687780d848b6c\", \"ios_web_view_inttests\": \"3be8d2f64b64295724120c3c3c767da52b1dfa44\", \"net_unittests\": \"2f775f3f29db865183c382166d4fc0fc615f6fb3\", \"skia_unittests\": \"d4066b0228a62d7753a9acc6fc29080e2902cd59\", \"sql_unittests\": \"d88dfdf8b4e8f4509675d065f57a7e14c881a5c5\", \"ui_base_unittests\": \"758ef5ac3e0f0ddb830fff8e5106e33a77a1708d\", \"url_unittests\": \"bb33b404b1d84a10d22e3b0a5c2531bb25cdfef5\"}, \"swarm_hashes_refs/heads/master(at){#764927}_without_patch\": {\"base_unittests\": \"41c3eac7140f6ae145aca07e800ccd2bc9c7eac2\", \"boringssl_crypto_tests\": \"b76ffb653270c634da70751e74ce94bb00be7529\", \"boringssl_ssl_tests\": \"0d577b4b796d0cd637c67f4d8e95a3de70220c00\", \"components_unittests\": \"41809d22b8f9a59181fbedd5ff40b2da18dde9f2\", \"crypto_unittests\": \"f607563a8c29475f2585afc4cd36817fc60da034\", \"gfx_unittests\": \"d4a4a1084bd713a7e7fc8e099bda70b1f0f8b4f0\", \"google_apis_unittests\": \"497c217017c93235beae22aefbb66688e773bee0\", \"ios_chrome_unittests\": \"b62a1c92bbc4abd130d49acc8313c58f2e461b5b\", \"ios_net_unittests\": \"b6e46ff92e3875a0e5bcd8af0d45e14ef3230420\", \"ios_web_inttests\": \"f8e2c18aabfdf5f3004c3d4ad4f78e56d6a420ac\", \"ios_web_unittests\": \"4041b020739627bfb1847ad7740687780d848b6c\", \"ios_web_view_inttests\": \"3be8d2f64b64295724120c3c3c767da52b1dfa44\", \"net_unittests\": \"2f775f3f29db865183c382166d4fc0fc615f6fb3\", \"skia_unittests\": \"d4066b0228a62d7753a9acc6fc29080e2902cd59\", \"sql_unittests\": \"d88dfdf8b4e8f4509675d065f57a7e14c881a5c5\", \"ui_base_unittests\": \"758ef5ac3e0f0ddb830fff8e5106e33a77a1708d\", \"url_unittests\": \"bb33b404b1d84a10d22e3b0a5c2531bb25cdfef5\"}, \"xcode_build_version\": \"11c29\"}, \"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_11c29\"], \"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\": [\"build283-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"5033-bf2739b\"], \"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": "1588433828720536",
"status": "COMPLETED",
"status_changed_ts": "1588441934768038",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/13920",
"builder:ToTiOS",
"buildset:commit/git/b5c8f2119351e7efd0b4ee0e3a43918640081edb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5c8f2119351e7efd0b4ee0e3a43918640081edb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046830190893532272",
"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/8881400128796543024/+/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:4beeda3aebc98010",
"user_agent:luci-scheduler"
],
"updated_ts": "1588441934798344",
"url": "https://ci.chromium.org/b/8881400128796543024",
"utcnow_ts": "1588441935435957"
}
}
[17:52:15.450] Invocation finished in 2h15m11.18574943s with status SUCCEEDED