[20:30:10.577] New invocation is queued and will start shortly
[20:30:11.715] Starting the invocation (attempt 1)
[20:30:11.757] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:11.757] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:11.758] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072541288823294912",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8d9534bad9a2dac2503fca20c2494b378327ea49\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9072541288823294912",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/8d9534bad9a2dac2503fca20c2494b378327ea49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d9534bad9a2dac2503fca20c2494b378327ea49",
"gitiles_ref:refs/heads/master"
]
}
[20:30:12.804] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563913811967318",
"id": "8907111226660922656",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8d9534bad9a2dac2503fca20c2494b378327ea49\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563913812606530",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8764",
"builder:ToTiOS",
"buildset:commit/git/8d9534bad9a2dac2503fca20c2494b378327ea49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d9534bad9a2dac2503fca20c2494b378327ea49",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072541288823294912",
"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/8907111226660922656/+/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": "1563913812606658",
"url": "https://ci.chromium.org/b/8907111226660922656",
"utcnow_ts": "1563913812787605"
}
}
[20:30:12.804] Task URL: https://ci.chromium.org/b/8907111226660922656
[20:30:12.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:2:0) after 1m0s
[20:30:16.684] Received PubSub notification, asking Buildbucket for the build status
[20:30:16.924] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:12.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:2:0)
[20:31:12.896] Timer tick, asking Buildbucket for the build status
[20:31:13.198] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:13.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:4:0) after 1m0s
[20:32:13.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:4:0)
[20:32:13.233] Timer tick, asking Buildbucket for the build status
[20:32:13.424] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:13.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:5:0) after 1m0s
[20:33:13.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:5:0)
[20:33:13.500] Timer tick, asking Buildbucket for the build status
[20:33:13.724] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:13.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:6:0) after 1m0s
[20:34:13.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:6:0)
[20:34:13.779] Timer tick, asking Buildbucket for the build status
[20:34:14.281] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:14.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:7:0) after 1m0s
[20:35:14.288] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:7:0)
[20:35:14.288] Timer tick, asking Buildbucket for the build status
[20:35:14.467] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:14.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:8:0) after 1m0s
[20:36:14.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:8:0)
[20:36:14.531] Timer tick, asking Buildbucket for the build status
[20:36:14.732] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:14.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:9:0) after 1m0s
[20:37:14.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:9:0)
[20:37:14.876] Timer tick, asking Buildbucket for the build status
[20:37:15.574] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:15.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:10:0) after 1m0s
[20:38:15.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:10:0)
[20:38:15.870] Timer tick, asking Buildbucket for the build status
[20:38:16.028] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:16.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:11:0) after 1m0s
[20:39:16.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:11:0)
[20:39:16.125] Timer tick, asking Buildbucket for the build status
[20:39:16.750] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:16.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:12:0) after 1m0s
[20:40:16.847] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:12:0)
[20:40:16.847] Timer tick, asking Buildbucket for the build status
[20:40:17.218] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:17.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:13:0) after 1m0s
[20:41:17.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:13:0)
[20:41:17.356] Timer tick, asking Buildbucket for the build status
[20:41:17.677] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:17.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:14:0) after 1m0s
[20:42:17.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:14:0)
[20:42:17.770] Timer tick, asking Buildbucket for the build status
[20:42:17.967] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:17.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:15:0) after 1m0s
[20:43:18.150] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:15:0)
[20:43:18.150] Timer tick, asking Buildbucket for the build status
[20:43:18.381] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:18.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:16:0) after 1m0s
[20:44:18.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:16:0)
[20:44:18.377] Timer tick, asking Buildbucket for the build status
[20:44:18.659] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:18.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:17:0) after 1m0s
[20:45:18.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:17:0)
[20:45:18.687] Timer tick, asking Buildbucket for the build status
[20:45:18.885] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:18.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:18:0) after 1m0s
[20:46:19.025] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:18:0)
[20:46:19.025] Timer tick, asking Buildbucket for the build status
[20:46:19.911] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:19.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:19:0) after 1m0s
[20:47:19.968] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:19:0)
[20:47:19.968] Timer tick, asking Buildbucket for the build status
[20:47:22.995] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:22.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:20:0) after 1m0s
[20:48:23.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:20:0)
[20:48:23.069] Timer tick, asking Buildbucket for the build status
[20:48:23.210] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:23.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:21:0) after 1m0s
[20:49:23.316] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:21:0)
[20:49:23.316] Timer tick, asking Buildbucket for the build status
[20:49:23.542] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:23.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:22:0) after 1m0s
[20:50:23.626] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:22:0)
[20:50:23.626] Timer tick, asking Buildbucket for the build status
[20:50:24.206] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:24.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:23:0) after 1m0s
[20:51:24.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:23:0)
[20:51:24.261] Timer tick, asking Buildbucket for the build status
[20:51:24.544] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:24.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:24:0) after 1m0s
[20:52:24.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:24:0)
[20:52:24.599] Timer tick, asking Buildbucket for the build status
[20:52:24.791] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:24.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:25:0) after 1m0s
[20:53:24.830] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:25:0)
[20:53:24.830] Timer tick, asking Buildbucket for the build status
[20:53:25.014] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:25.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:26:0) after 1m0s
[20:54:25.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:26:0)
[20:54:25.121] Timer tick, asking Buildbucket for the build status
[20:54:25.971] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:25.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:27:0) after 1m0s
[20:55:26.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:27:0)
[20:55:26.002] Timer tick, asking Buildbucket for the build status
[20:55:27.022] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:27.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:28:0) after 1m0s
[20:56:27.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:28:0)
[20:56:27.028] Timer tick, asking Buildbucket for the build status
[20:56:27.383] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:27.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:29:0) after 1m0s
[20:57:27.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:29:0)
[20:57:27.449] Timer tick, asking Buildbucket for the build status
[20:57:27.842] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:27.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:30:0) after 1m0s
[20:58:27.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:30:0)
[20:58:27.975] Timer tick, asking Buildbucket for the build status
[20:58:28.234] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:28.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:31:0) after 1m0s
[20:59:28.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:31:0)
[20:59:28.307] Timer tick, asking Buildbucket for the build status
[20:59:28.558] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:28.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:32:0) after 1m0s
[21:00:28.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:32:0)
[21:00:28.633] Timer tick, asking Buildbucket for the build status
[21:00:28.738] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:28.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:33:0) after 1m0s
[21:01:28.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:33:0)
[21:01:28.771] Timer tick, asking Buildbucket for the build status
[21:01:28.976] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:28.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:34:0) after 1m0s
[21:02:29.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:34:0)
[21:02:29.045] Timer tick, asking Buildbucket for the build status
[21:02:29.436] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:29.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:35:0) after 1m0s
[21:03:29.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:35:0)
[21:03:29.555] Timer tick, asking Buildbucket for the build status
[21:03:29.781] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:29.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:36:0) after 1m0s
[21:04:29.854] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:36:0)
[21:04:29.854] Timer tick, asking Buildbucket for the build status
[21:04:30.421] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:30.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:37:0) after 1m0s
[21:05:30.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:37:0)
[21:05:30.473] Timer tick, asking Buildbucket for the build status
[21:05:30.701] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:30.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:38:0) after 1m0s
[21:06:30.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:38:0)
[21:06:30.747] Timer tick, asking Buildbucket for the build status
[21:06:31.171] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:31.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:39:0) after 1m0s
[21:07:31.230] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:39:0)
[21:07:31.230] Timer tick, asking Buildbucket for the build status
[21:07:31.894] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:31.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:40:0) after 1m0s
[21:08:31.882] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:40:0)
[21:08:31.882] Timer tick, asking Buildbucket for the build status
[21:08:32.266] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:32.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:41:0) after 1m0s
[21:09:32.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:41:0)
[21:09:32.295] Timer tick, asking Buildbucket for the build status
[21:09:32.455] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:32.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:42:0) after 1m0s
[21:10:32.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:42:0)
[21:10:32.582] Timer tick, asking Buildbucket for the build status
[21:10:32.827] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:32.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:43:0) after 1m0s
[21:11:33.176] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:43:0)
[21:11:33.176] Timer tick, asking Buildbucket for the build status
[21:11:33.637] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:33.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:44:0) after 1m0s
[21:12:33.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:44:0)
[21:12:33.744] Timer tick, asking Buildbucket for the build status
[21:12:33.903] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:33.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:45:0) after 1m0s
[21:13:34.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:45:0)
[21:13:34.154] Timer tick, asking Buildbucket for the build status
[21:13:34.337] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:34.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:46:0) after 1m0s
[21:14:34.554] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:46:0)
[21:14:34.554] Timer tick, asking Buildbucket for the build status
[21:14:35.374] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:35.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:47:0) after 1m0s
[21:15:35.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:47:0)
[21:15:35.527] Timer tick, asking Buildbucket for the build status
[21:15:35.988] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:35.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:48:0) after 1m0s
[21:16:35.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:48:0)
[21:16:35.998] Timer tick, asking Buildbucket for the build status
[21:16:36.677] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:36.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:49:0) after 1m0s
[21:17:36.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:49:0)
[21:17:36.943] Timer tick, asking Buildbucket for the build status
[21:17:38.001] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:38.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:50:0) after 1m0s
[21:18:38.070] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:50:0)
[21:18:38.070] Timer tick, asking Buildbucket for the build status
[21:18:38.568] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:38.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:51:0) after 1m0s
[21:19:38.639] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:51:0)
[21:19:38.639] Timer tick, asking Buildbucket for the build status
[21:19:38.886] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:38.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:52:0) after 1m0s
[21:20:38.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:52:0)
[21:20:38.917] Timer tick, asking Buildbucket for the build status
[21:20:39.582] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:39.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:53:0) after 1m0s
[21:21:39.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:53:0)
[21:21:39.654] Timer tick, asking Buildbucket for the build status
[21:21:39.975] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:39.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:54:0) after 1m0s
[21:22:40.153] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:54:0)
[21:22:40.153] Timer tick, asking Buildbucket for the build status
[21:22:40.741] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:40.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:55:0) after 1m0s
[21:23:40.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:55:0)
[21:23:40.796] Timer tick, asking Buildbucket for the build status
[21:23:41.131] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:41.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:56:0) after 1m0s
[21:24:41.310] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:56:0)
[21:24:41.310] Timer tick, asking Buildbucket for the build status
[21:24:41.540] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:41.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:57:0) after 1m0s
[21:25:41.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:57:0)
[21:25:41.611] Timer tick, asking Buildbucket for the build status
[21:25:41.978] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:41.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:58:0) after 1m0s
[21:26:42.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:58:0)
[21:26:42.001] Timer tick, asking Buildbucket for the build status
[21:26:42.390] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:42.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:59:0) after 1m0s
[21:27:42.488] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:59:0)
[21:27:42.488] Timer tick, asking Buildbucket for the build status
[21:27:42.721] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:42.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:60:0) after 1m0s
[21:28:42.843] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:60:0)
[21:28:42.843] Timer tick, asking Buildbucket for the build status
[21:28:43.256] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:43.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:61:0) after 1m0s
[21:29:43.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:61:0)
[21:29:43.398] Timer tick, asking Buildbucket for the build status
[21:29:43.916] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:43.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:62:0) after 1m0s
[21:30:43.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:62:0)
[21:30:43.958] Timer tick, asking Buildbucket for the build status
[21:30:44.181] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:44.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:63:0) after 1m0s
[21:31:44.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:63:0)
[21:31:44.218] Timer tick, asking Buildbucket for the build status
[21:31:44.374] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:44.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:64:0) after 1m0s
[21:32:44.460] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:64:0)
[21:32:44.460] Timer tick, asking Buildbucket for the build status
[21:32:45.126] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:45.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:65:0) after 1m0s
[21:33:45.267] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:65:0)
[21:33:45.267] Timer tick, asking Buildbucket for the build status
[21:33:46.127] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:46.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:66:0) after 1m0s
[21:34:46.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:66:0)
[21:34:46.249] Timer tick, asking Buildbucket for the build status
[21:34:46.835] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:46.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:67:0) after 1m0s
[21:35:46.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:67:0)
[21:35:46.967] Timer tick, asking Buildbucket for the build status
[21:35:47.144] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:47.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:68:0) after 1m0s
[21:36:47.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:68:0)
[21:36:47.880] Timer tick, asking Buildbucket for the build status
[21:36:48.825] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:48.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:69:0) after 1m0s
[21:37:49.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:69:0)
[21:37:49.041] Timer tick, asking Buildbucket for the build status
[21:37:49.471] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:49.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:70:0) after 1m0s
[21:38:49.550] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:70:0)
[21:38:49.550] Timer tick, asking Buildbucket for the build status
[21:38:49.929] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:49.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:71:0) after 1m0s
[21:39:49.990] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:71:0)
[21:39:49.990] Timer tick, asking Buildbucket for the build status
[21:39:50.355] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:50.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:72:0) after 1m0s
[21:40:50.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:72:0)
[21:40:50.437] Timer tick, asking Buildbucket for the build status
[21:40:50.634] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:50.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:73:0) after 1m0s
[21:41:50.671] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:73:0)
[21:41:50.671] Timer tick, asking Buildbucket for the build status
[21:41:51.171] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:51.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:74:0) after 1m0s
[21:42:51.250] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:74:0)
[21:42:51.250] Timer tick, asking Buildbucket for the build status
[21:42:51.683] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:51.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:75:0) after 1m0s
[21:43:52.155] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:75:0)
[21:43:52.155] Timer tick, asking Buildbucket for the build status
[21:43:53.644] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:53.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:76:0) after 1m0s
[21:44:53.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:76:0)
[21:44:53.927] Timer tick, asking Buildbucket for the build status
[21:44:54.247] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:54.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:77:0) after 1m0s
[21:45:54.384] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:77:0)
[21:45:54.384] Timer tick, asking Buildbucket for the build status
[21:45:54.923] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:54.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:78:0) after 1m0s
[21:46:54.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:78:0)
[21:46:54.983] Timer tick, asking Buildbucket for the build status
[21:46:55.404] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:55.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:79:0) after 1m0s
[21:47:55.573] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:79:0)
[21:47:55.573] Timer tick, asking Buildbucket for the build status
[21:47:55.904] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:55.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:80:0) after 1m0s
[21:48:56.022] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:80:0)
[21:48:56.022] Timer tick, asking Buildbucket for the build status
[21:48:56.351] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:56.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:81:0) after 1m0s
[21:49:56.397] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:81:0)
[21:49:56.397] Timer tick, asking Buildbucket for the build status
[21:49:57.141] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:57.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:82:0) after 1m0s
[21:50:57.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:82:0)
[21:50:57.208] Timer tick, asking Buildbucket for the build status
[21:51:00.058] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:00.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:83:0) after 1m0s
[21:52:00.095] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:83:0)
[21:52:00.095] Timer tick, asking Buildbucket for the build status
[21:52:00.291] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:00.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:84:0) after 1m0s
[21:53:00.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:84:0)
[21:53:00.324] Timer tick, asking Buildbucket for the build status
[21:53:00.527] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:00.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:85:0) after 1m0s
[21:54:00.551] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:85:0)
[21:54:00.551] Timer tick, asking Buildbucket for the build status
[21:54:00.745] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:00.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:86:0) after 1m0s
[21:55:00.831] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:86:0)
[21:55:00.831] Timer tick, asking Buildbucket for the build status
[21:55:01.802] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:01.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:87:0) after 1m0s
[21:56:01.786] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:87:0)
[21:56:01.786] Timer tick, asking Buildbucket for the build status
[21:56:01.961] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:01.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:88:0) after 1m0s
[21:57:01.990] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:88:0)
[21:57:01.990] Timer tick, asking Buildbucket for the build status
[21:57:02.455] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:02.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:89:0) after 1m0s
[21:58:02.495] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:89:0)
[21:58:02.495] Timer tick, asking Buildbucket for the build status
[21:58:02.629] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:02.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:90:0) after 1m0s
[21:59:02.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:90:0)
[21:59:02.686] Timer tick, asking Buildbucket for the build status
[21:59:02.844] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:02.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:91:0) after 1m0s
[22:00:03.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:91:0)
[22:00:03.029] Timer tick, asking Buildbucket for the build status
[22:00:03.300] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:03.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:92:0) after 1m0s
[22:01:03.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:92:0)
[22:01:03.337] Timer tick, asking Buildbucket for the build status
[22:01:03.920] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:03.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:93:0) after 1m0s
[22:02:03.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:93:0)
[22:02:03.980] Timer tick, asking Buildbucket for the build status
[22:02:04.461] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:04.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:94:0) after 1m0s
[22:03:04.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:94:0)
[22:03:04.583] Timer tick, asking Buildbucket for the build status
[22:03:04.802] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:04.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:95:0) after 1m0s
[22:04:04.864] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:95:0)
[22:04:04.864] Timer tick, asking Buildbucket for the build status
[22:04:05.148] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:05.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:96:0) after 1m0s
[22:05:05.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:96:0)
[22:05:05.311] Timer tick, asking Buildbucket for the build status
[22:05:08.567] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:08.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:97:0) after 1m0s
[22:06:08.685] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:97:0)
[22:06:08.685] Timer tick, asking Buildbucket for the build status
[22:06:09.851] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:09.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:98:0) after 1m0s
[22:07:09.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:98:0)
[22:07:09.950] Timer tick, asking Buildbucket for the build status
[22:07:10.401] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:10.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:99:0) after 1m0s
[22:08:10.433] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:99:0)
[22:08:10.433] Timer tick, asking Buildbucket for the build status
[22:08:10.765] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:10.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:100:0) after 1m0s
[22:09:10.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:100:0)
[22:09:10.789] Timer tick, asking Buildbucket for the build status
[22:09:10.980] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:10.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:101:0) after 1m0s
[22:10:11.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:101:0)
[22:10:11.121] Timer tick, asking Buildbucket for the build status
[22:10:11.548] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:11.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:102:0) after 1m0s
[22:11:11.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:102:0)
[22:11:11.605] Timer tick, asking Buildbucket for the build status
[22:11:11.839] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:11.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:103:0) after 1m0s
[22:12:11.869] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:103:0)
[22:12:11.869] Timer tick, asking Buildbucket for the build status
[22:12:13.303] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:13.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:104:0) after 1m0s
[22:13:13.340] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:104:0)
[22:13:13.340] Timer tick, asking Buildbucket for the build status
[22:13:14.645] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:14.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:105:0) after 1m0s
[22:14:14.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:105:0)
[22:14:14.722] Timer tick, asking Buildbucket for the build status
[22:14:14.886] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:14.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:106:0) after 1m0s
[22:15:14.933] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:106:0)
[22:15:14.933] Timer tick, asking Buildbucket for the build status
[22:15:15.148] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:15.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:107:0) after 1m0s
[22:16:15.170] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:107:0)
[22:16:15.170] Timer tick, asking Buildbucket for the build status
[22:16:16.576] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:16.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:108:0) after 1m0s
[22:17:16.674] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:108:0)
[22:17:16.674] Timer tick, asking Buildbucket for the build status
[22:17:17.069] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:17.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:109:0) after 1m0s
[22:18:17.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:109:0)
[22:18:17.078] Timer tick, asking Buildbucket for the build status
[22:18:17.340] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:17.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:110:0) after 1m0s
[22:19:17.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:110:0)
[22:19:17.389] Timer tick, asking Buildbucket for the build status
[22:19:17.608] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:17.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:111:0) after 1m0s
[22:20:17.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:111:0)
[22:20:17.590] Timer tick, asking Buildbucket for the build status
[22:20:18.391] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:18.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:112:0) after 1m0s
[22:21:18.436] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:112:0)
[22:21:18.436] Timer tick, asking Buildbucket for the build status
[22:21:19.013] Build 8907111226660922656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:19.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072541288823294912:113:0) after 1m0s
[22:21:40.396] Received PubSub notification, asking Buildbucket for the build status
[22:21:40.879] Build 8907111226660922656: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:21:40.879] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563920499652786",
"created_by": "project:chromium",
"created_ts": "1563913811967318",
"id": "8907111226660922656",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8d9534bad9a2dac2503fca20c2494b378327ea49\"}}",
"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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8764, \"got_angle_revision\": \"dd3de6f095c1a0e8b7c4fff579541287ab2f4fe6\", \"got_dawn_revision\": \"68d97adf88de11cd9c5b9e2f9a77d50ab985ede4\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"8d9534bad9a2dac2503fca20c2494b378327ea49\", \"got_revision_cp\": \"refs/heads/master@{#680126}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"109b30b38f8365b80ff4b7c563d19264789d6865\", \"got_v8_revision_cp\": \"refs/heads/7.7.297@{#1}\", \"got_webrtc_revision\": \"cfefa0aef329aac0206c5e56efd90b3b0bdb88b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28646}\", \"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\": \"8d9534bad9a2dac2503fca20c2494b378327ea49\", \"swarm_hashes\": {\"0\": \"2568402eca90e3d866b05858bcf61ff3e0faf12a\", \"1\": \"cce9502acd5926cb150993ba1959a81289e1ed90\", \"10\": \"5dfa6c668381a7c1bb1bba75ff80613b01f4ab0c\", \"11\": \"2070922bebd37eb1f2b05afce548853ebbbe4c09\", \"12\": \"644eebe5beeb8da52c9ad1c2f7770bd162ba2566\", \"13\": \"01c01ca0be1ae474e0c51aa2ac544ec3da2fa5f9\", \"14\": \"56b3eeed62409655007d192bbd342e546bb4460c\", \"15\": \"54d08f3c6df2d101db270a014062693e5f35be46\", \"16\": \"a26918dc10f87d3d6260f82718397dfdc512baaf\", \"2\": \"337a93a452ac2c3696e7f01fb118e38fa339b97e\", \"3\": \"4bd81808fbc29f243693fc1d43fb60036919421f\", \"4\": \"b545395feae6e39543b777ab37a6e2fb60cda530\", \"5\": \"b4a2a348fbfd30b6e1b6cb7d7cf7d086292a0bf0\", \"6\": \"00d1c111c40e5e7fbdb7634024bd04f2e8dde97e\", \"7\": \"8b86f8ebca43c2b23c4a076845893c6137c91afc\", \"8\": \"af5cf8dedb212f0fc7e6e1e9a491c2fc8b8dee4e\", \"9\": \"23460d361ae0bd9d848852c69635dc9a259284da\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_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\": [\"build282-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\": [\"4382-5929880\"], \"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": "1563913815614792",
"status": "COMPLETED",
"status_changed_ts": "1563920500046802",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8764",
"builder:ToTiOS",
"buildset:commit/git/8d9534bad9a2dac2503fca20c2494b378327ea49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d9534bad9a2dac2503fca20c2494b378327ea49",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072541288823294912",
"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/8907111226660922656/+/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:463958847fb24510",
"user_agent:luci-scheduler"
],
"updated_ts": "1563920500054455",
"url": "https://ci.chromium.org/b/8907111226660922656",
"utcnow_ts": "1563920500860953"
}
}
[22:21:40.879] Invocation finished in 1h51m30.35782297s with status SUCCEEDED