[21:15:20.087] New invocation is queued and will start shortly
[21:15:21.184] Starting the invocation (attempt 1)
[21:15:21.234] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:15:21.234] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:15:21.234] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9079333220137208800",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9079333220137208800",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731",
"gitiles_ref:refs/heads/master"
]
}
[21:15:29.846] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1557436525168077",
"id": "8913903154144059424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557436528452103",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12301",
"builder:linux-chromeos-dbg",
"buildset:commit/git/052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079333220137208800",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8913903154144059424/+/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": "1557436528453081",
"url": "https://ci.chromium.org/b/8913903154144059424",
"utcnow_ts": "1557436529784269"
}
}
[21:15:29.846] Task URL: https://ci.chromium.org/b/8913903154144059424
[21:15:29.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:2:0) after 1m0s
[21:15:36.482] Received PubSub notification, asking Buildbucket for the build status
[21:15:37.528] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:29.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:2:0)
[21:16:29.876] Timer tick, asking Buildbucket for the build status
[21:16:30.047] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:30.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:4:0) after 1m0s
[21:17:30.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:4:0)
[21:17:30.043] Timer tick, asking Buildbucket for the build status
[21:17:30.331] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:30.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:5:0) after 1m0s
[21:18:30.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:5:0)
[21:18:30.357] Timer tick, asking Buildbucket for the build status
[21:18:33.202] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:33.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:6:0) after 1m0s
[21:19:33.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:6:0)
[21:19:33.328] Timer tick, asking Buildbucket for the build status
[21:19:36.072] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:36.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:7:0) after 1m0s
[21:20:36.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:7:0)
[21:20:36.095] Timer tick, asking Buildbucket for the build status
[21:20:36.559] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:36.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:8:0) after 1m0s
[21:21:36.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:8:0)
[21:21:36.550] Timer tick, asking Buildbucket for the build status
[21:21:36.727] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:36.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:9:0) after 1m0s
[21:22:37.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:9:0)
[21:22:37.094] Timer tick, asking Buildbucket for the build status
[21:22:37.262] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:37.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:10:0) after 1m0s
[21:23:37.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:10:0)
[21:23:37.313] Timer tick, asking Buildbucket for the build status
[21:23:38.129] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:38.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:11:0) after 1m0s
[21:24:38.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:11:0)
[21:24:38.680] Timer tick, asking Buildbucket for the build status
[21:24:38.919] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:38.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:12:0) after 1m0s
[21:25:39.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:12:0)
[21:25:39.264] Timer tick, asking Buildbucket for the build status
[21:25:39.995] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:39.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:13:0) after 1m0s
[21:26:40.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:13:0)
[21:26:40.136] Timer tick, asking Buildbucket for the build status
[21:26:40.533] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:40.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:14:0) after 1m0s
[21:27:40.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:14:0)
[21:27:40.998] Timer tick, asking Buildbucket for the build status
[21:27:41.165] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:41.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:15:0) after 1m0s
[21:28:41.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:15:0)
[21:28:41.336] Timer tick, asking Buildbucket for the build status
[21:28:41.595] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:41.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:16:0) after 1m0s
[21:29:41.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:16:0)
[21:29:41.595] Timer tick, asking Buildbucket for the build status
[21:29:42.500] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:42.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:17:0) after 1m0s
[21:30:42.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:17:0)
[21:30:42.575] Timer tick, asking Buildbucket for the build status
[21:30:42.762] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:42.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:18:0) after 1m0s
[21:31:42.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:18:0)
[21:31:42.775] Timer tick, asking Buildbucket for the build status
[21:31:42.939] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:42.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:19:0) after 1m0s
[21:32:43.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:19:0)
[21:32:43.086] Timer tick, asking Buildbucket for the build status
[21:32:44.728] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:44.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:20:0) after 1m0s
[21:33:44.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:20:0)
[21:33:44.734] Timer tick, asking Buildbucket for the build status
[21:33:46.872] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:46.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:21:0) after 1m0s
[21:34:46.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:21:0)
[21:34:46.898] Timer tick, asking Buildbucket for the build status
[21:34:47.341] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:47.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:22:0) after 1m0s
[21:35:47.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:22:0)
[21:35:47.378] Timer tick, asking Buildbucket for the build status
[21:35:49.597] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:49.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:23:0) after 1m0s
[21:36:49.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:23:0)
[21:36:49.573] Timer tick, asking Buildbucket for the build status
[21:36:50.019] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:50.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:24:0) after 1m0s
[21:37:50.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:24:0)
[21:37:50.032] Timer tick, asking Buildbucket for the build status
[21:37:50.946] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:50.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:25:0) after 1m0s
[21:38:52.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:25:0)
[21:38:52.142] Timer tick, asking Buildbucket for the build status
[21:38:52.731] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:52.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:26:0) after 1m0s
[21:39:52.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:26:0)
[21:39:52.714] Timer tick, asking Buildbucket for the build status
[21:39:53.052] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:53.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:27:0) after 1m0s
[21:40:53.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:27:0)
[21:40:53.264] Timer tick, asking Buildbucket for the build status
[21:40:53.882] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:53.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:28:0) after 1m0s
[21:41:54.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:28:0)
[21:41:54.214] Timer tick, asking Buildbucket for the build status
[21:41:54.918] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:54.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:29:0) after 1m0s
[21:42:54.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:29:0)
[21:42:54.940] Timer tick, asking Buildbucket for the build status
[21:42:59.425] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:59.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:30:0) after 1m0s
[21:43:59.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:30:0)
[21:43:59.615] Timer tick, asking Buildbucket for the build status
[21:43:59.915] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:59.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:31:0) after 1m0s
[21:44:59.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:31:0)
[21:44:59.932] Timer tick, asking Buildbucket for the build status
[21:45:00.722] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:00.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:32:0) after 1m0s
[21:46:00.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:32:0)
[21:46:00.738] Timer tick, asking Buildbucket for the build status
[21:46:01.211] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:01.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:33:0) after 1m0s
[21:47:01.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:33:0)
[21:47:01.250] Timer tick, asking Buildbucket for the build status
[21:47:01.984] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:01.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:34:0) after 1m0s
[21:48:02.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:34:0)
[21:48:02.004] Timer tick, asking Buildbucket for the build status
[21:48:02.495] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:02.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:35:0) after 1m0s
[21:49:02.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:35:0)
[21:49:02.559] Timer tick, asking Buildbucket for the build status
[21:49:10.284] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:10.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:36:0) after 1m0s
[21:50:10.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:36:0)
[21:50:10.286] Timer tick, asking Buildbucket for the build status
[21:50:10.858] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:10.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:37:0) after 1m0s
[21:51:10.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:37:0)
[21:51:10.970] Timer tick, asking Buildbucket for the build status
[21:51:11.267] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:11.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:38:0) after 1m0s
[21:52:11.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:38:0)
[21:52:11.308] Timer tick, asking Buildbucket for the build status
[21:52:11.692] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:11.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:39:0) after 1m0s
[21:53:11.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:39:0)
[21:53:11.690] Timer tick, asking Buildbucket for the build status
[21:53:11.911] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:11.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:40:0) after 1m0s
[21:54:11.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:40:0)
[21:54:11.919] Timer tick, asking Buildbucket for the build status
[21:54:13.647] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:13.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:41:0) after 1m0s
[21:55:13.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:41:0)
[21:55:13.673] Timer tick, asking Buildbucket for the build status
[21:55:13.941] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:13.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:42:0) after 1m0s
[21:56:13.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:42:0)
[21:56:13.988] Timer tick, asking Buildbucket for the build status
[21:56:16.095] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:16.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:43:0) after 1m0s
[21:57:16.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:43:0)
[21:57:16.174] Timer tick, asking Buildbucket for the build status
[21:57:16.509] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:16.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:44:0) after 1m0s
[21:58:16.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:44:0)
[21:58:16.533] Timer tick, asking Buildbucket for the build status
[21:58:16.738] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:16.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:45:0) after 1m0s
[21:59:16.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:45:0)
[21:59:16.836] Timer tick, asking Buildbucket for the build status
[21:59:17.013] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:17.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:46:0) after 1m0s
[22:00:17.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:46:0)
[22:00:17.040] Timer tick, asking Buildbucket for the build status
[22:00:17.238] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:17.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:47:0) after 1m0s
[22:01:17.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:47:0)
[22:01:17.271] Timer tick, asking Buildbucket for the build status
[22:01:18.098] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:18.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:48:0) after 1m0s
[22:02:18.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:48:0)
[22:02:18.126] Timer tick, asking Buildbucket for the build status
[22:02:21.108] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:21.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:49:0) after 1m0s
[22:03:21.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:49:0)
[22:03:21.151] Timer tick, asking Buildbucket for the build status
[22:03:22.376] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:22.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:50:0) after 1m0s
[22:04:22.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:50:0)
[22:04:22.406] Timer tick, asking Buildbucket for the build status
[22:04:26.486] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:26.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:51:0) after 1m0s
[22:05:26.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:51:0)
[22:05:26.518] Timer tick, asking Buildbucket for the build status
[22:05:27.146] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:27.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:52:0) after 1m0s
[22:06:27.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:52:0)
[22:06:27.174] Timer tick, asking Buildbucket for the build status
[22:06:27.576] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:27.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:53:0) after 1m0s
[22:07:27.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:53:0)
[22:07:27.614] Timer tick, asking Buildbucket for the build status
[22:07:28.313] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:28.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:54:0) after 1m0s
[22:08:28.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:54:0)
[22:08:28.310] Timer tick, asking Buildbucket for the build status
[22:08:29.437] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:29.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:55:0) after 1m0s
[22:09:29.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:55:0)
[22:09:29.476] Timer tick, asking Buildbucket for the build status
[22:09:30.321] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:30.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:56:0) after 1m0s
[22:10:30.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:56:0)
[22:10:30.402] Timer tick, asking Buildbucket for the build status
[22:10:31.911] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:31.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:57:0) after 1m0s
[22:11:31.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:57:0)
[22:11:31.927] Timer tick, asking Buildbucket for the build status
[22:11:34.600] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:34.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:58:0) after 1m0s
[22:12:34.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:58:0)
[22:12:34.751] Timer tick, asking Buildbucket for the build status
[22:12:34.855] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:34.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:59:0) after 1m0s
[22:13:34.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:59:0)
[22:13:34.893] Timer tick, asking Buildbucket for the build status
[22:13:36.570] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:36.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:60:0) after 1m0s
[22:14:36.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:60:0)
[22:14:36.609] Timer tick, asking Buildbucket for the build status
[22:14:37.394] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:37.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:61:0) after 1m0s
[22:15:37.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:61:0)
[22:15:37.414] Timer tick, asking Buildbucket for the build status
[22:15:37.937] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:37.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:62:0) after 1m0s
[22:16:37.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:62:0)
[22:16:37.942] Timer tick, asking Buildbucket for the build status
[22:16:38.508] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:38.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:63:0) after 1m0s
[22:17:38.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:63:0)
[22:17:38.535] Timer tick, asking Buildbucket for the build status
[22:17:40.635] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:40.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:64:0) after 1m0s
[22:18:40.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:64:0)
[22:18:40.644] Timer tick, asking Buildbucket for the build status
[22:18:40.816] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:40.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:65:0) after 1m0s
[22:19:40.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:65:0)
[22:19:40.834] Timer tick, asking Buildbucket for the build status
[22:19:40.986] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:40.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:66:0) after 1m0s
[22:20:41.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:66:0)
[22:20:41.010] Timer tick, asking Buildbucket for the build status
[22:20:41.366] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:41.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:67:0) after 1m0s
[22:21:41.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:67:0)
[22:21:41.629] Timer tick, asking Buildbucket for the build status
[22:21:41.779] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:41.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:68:0) after 1m0s
[22:22:41.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:68:0)
[22:22:41.768] Timer tick, asking Buildbucket for the build status
[22:22:42.409] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:42.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:69:0) after 1m0s
[22:23:42.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:69:0)
[22:23:42.474] Timer tick, asking Buildbucket for the build status
[22:23:42.585] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:42.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:70:0) after 1m0s
[22:24:42.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:70:0)
[22:24:42.615] Timer tick, asking Buildbucket for the build status
[22:24:43.369] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:43.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:71:0) after 1m0s
[22:25:43.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:71:0)
[22:25:43.403] Timer tick, asking Buildbucket for the build status
[22:25:48.574] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:48.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:72:0) after 1m0s
[22:26:48.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:72:0)
[22:26:48.620] Timer tick, asking Buildbucket for the build status
[22:26:51.299] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:51.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:73:0) after 1m0s
[22:27:51.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:73:0)
[22:27:51.299] Timer tick, asking Buildbucket for the build status
[22:27:52.433] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:52.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:74:0) after 1m0s
[22:28:52.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:74:0)
[22:28:52.458] Timer tick, asking Buildbucket for the build status
[22:28:52.896] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:52.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:75:0) after 1m0s
[22:29:52.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:75:0)
[22:29:52.929] Timer tick, asking Buildbucket for the build status
[22:29:54.664] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:54.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:76:0) after 1m0s
[22:30:54.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:76:0)
[22:30:54.755] Timer tick, asking Buildbucket for the build status
[22:30:54.886] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:54.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:77:0) after 1m0s
[22:31:54.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:77:0)
[22:31:54.869] Timer tick, asking Buildbucket for the build status
[22:31:55.069] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:55.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:78:0) after 1m0s
[22:32:55.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:78:0)
[22:32:55.106] Timer tick, asking Buildbucket for the build status
[22:32:55.328] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:55.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:79:0) after 1m0s
[22:33:55.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:79:0)
[22:33:55.339] Timer tick, asking Buildbucket for the build status
[22:33:59.109] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:59.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:80:0) after 1m0s
[22:34:59.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:80:0)
[22:34:59.150] Timer tick, asking Buildbucket for the build status
[22:34:59.503] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:59.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:81:0) after 1m0s
[22:35:59.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:81:0)
[22:35:59.501] Timer tick, asking Buildbucket for the build status
[22:36:01.767] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:01.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:82:0) after 1m0s
[22:37:01.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:82:0)
[22:37:01.788] Timer tick, asking Buildbucket for the build status
[22:37:06.924] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:06.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:83:0) after 1m0s
[22:38:06.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:83:0)
[22:38:06.947] Timer tick, asking Buildbucket for the build status
[22:38:07.333] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:07.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:84:0) after 1m0s
[22:39:07.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:84:0)
[22:39:07.333] Timer tick, asking Buildbucket for the build status
[22:39:08.954] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:08.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:85:0) after 1m0s
[22:40:08.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:85:0)
[22:40:08.974] Timer tick, asking Buildbucket for the build status
[22:40:09.233] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:09.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:86:0) after 1m0s
[22:41:09.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:86:0)
[22:41:09.222] Timer tick, asking Buildbucket for the build status
[22:41:10.914] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:10.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:87:0) after 1m0s
[22:42:10.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:87:0)
[22:42:10.916] Timer tick, asking Buildbucket for the build status
[22:42:11.943] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:11.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:88:0) after 1m0s
[22:43:11.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:88:0)
[22:43:11.968] Timer tick, asking Buildbucket for the build status
[22:43:13.089] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:13.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:89:0) after 1m0s
[22:44:13.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:89:0)
[22:44:13.128] Timer tick, asking Buildbucket for the build status
[22:44:13.318] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:13.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:90:0) after 1m0s
[22:45:13.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:90:0)
[22:45:13.450] Timer tick, asking Buildbucket for the build status
[22:45:14.823] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:14.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:91:0) after 1m0s
[22:46:14.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:91:0)
[22:46:14.854] Timer tick, asking Buildbucket for the build status
[22:46:15.607] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:15.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:92:0) after 1m0s
[22:47:15.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:92:0)
[22:47:15.650] Timer tick, asking Buildbucket for the build status
[22:47:15.797] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:15.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:93:0) after 1m0s
[22:48:15.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:93:0)
[22:48:15.820] Timer tick, asking Buildbucket for the build status
[22:48:16.137] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:16.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:94:0) after 1m0s
[22:49:16.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:94:0)
[22:49:16.177] Timer tick, asking Buildbucket for the build status
[22:49:16.404] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:16.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:95:0) after 1m0s
[22:50:16.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:95:0)
[22:50:16.412] Timer tick, asking Buildbucket for the build status
[22:50:17.099] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:17.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:96:0) after 1m0s
[22:51:17.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:96:0)
[22:51:17.128] Timer tick, asking Buildbucket for the build status
[22:51:17.653] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:17.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:97:0) after 1m0s
[22:52:17.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:97:0)
[22:52:17.693] Timer tick, asking Buildbucket for the build status
[22:52:18.678] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:18.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:98:0) after 1m0s
[22:53:18.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:98:0)
[22:53:18.769] Timer tick, asking Buildbucket for the build status
[22:53:20.467] Build 8913903154144059424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:20.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079333220137208800:99:0) after 1m0s
[22:53:54.132] Received PubSub notification, asking Buildbucket for the build status
[22:53:54.897] Build 8913903154144059424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:53:54.897] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1557442430579576",
"created_by": "project:chromium",
"created_ts": "1557436525168077",
"id": "8913903154144059424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 12301, \"got_angle_revision\": \"064b1625059a66f15240412e084f2948b2d24e1b\", \"got_dawn_revision\": \"974a1503273543719df2a3a18a967a4a785d49f1\", \"got_nacl_revision\": \"ca374f5112fca6b36fc5d73e117a60b82f394993\", \"got_revision\": \"052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731\", \"got_revision_cp\": \"refs/heads/master@{#658273}\", \"got_swarming_client_revision\": \"1b65f4e862045f3ba430a4cbd0643f5b1b66c230\", \"got_v8_revision\": \"a74147972b6713fbd1d99ebd789dfef29067281c\", \"got_v8_revision_cp\": \"refs/heads/7.6.141@{#1}\", \"got_webrtc_revision\": \"bf47f340ee2e11d297f6dc14f5d76abbe7c9a1e2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27891}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731\", \"swarm_hashes\": {\"accessibility_unittests\": \"e488edcb6cdff714eba430bda2f7c2d5298b1a66\", \"angle_unittests\": \"b0d586abe4f28fba6322d2985d9ce4db557ceada\", \"app_list_unittests\": \"c61ba6530d76a36d07d262d581dae39e57811cfc\", \"app_shell_unittests\": \"c5f5b41f17ddbaea567a8e9147bbb5a7ef513a71\", \"ash_unittests\": \"d02a86ab1c38eb88a9bb82cba7f1840237f6ce24\", \"aura_unittests\": \"f8f7c43635fdcfa614de44edd174c44a018ed421\", \"base_unittests\": \"a26230c2fdeab4872a9c3174c522e099f12336b3\", \"base_util_unittests\": \"f9b4d3b44810334bd9cd6918a0a11c401cdf0eb3\", \"blink_common_unittests\": \"dd62e3073b765d505dca6c8326ab3fcf7cbb1969\", \"blink_fuzzer_unittests\": \"42227512774b1f22ad3dbf8226735b1ea2d76de1\", \"blink_heap_unittests\": \"0b9dc2203613869e81a1f5cb56e5d5a1f2e41fc4\", \"blink_platform_unittests\": \"7117e4289dd9caab9724df56a466a4631581650d\", \"blink_unittests\": \"df1f5e138aab2881aacf5badd0f5cba580769848\", \"boringssl_crypto_tests\": \"31f7b61527601602813a6bea02818702a2ff857e\", \"boringssl_ssl_tests\": \"8371532b41c1df5c6f1d9408753af41a9a8ffe52\", \"browser_tests\": \"c98e5f301b1d78f7f6632e163254d8b675ea03e2\", \"cacheinvalidation_unittests\": \"f21051f4a2b809b0275f72d6cf8c197fb17fd2a4\", \"capture_unittests\": \"f971c1d08efa1a35fbf9f7cb9727be8c03585c40\", \"cast_unittests\": \"50cdd40f1d2409c9a4f2272f39e4dd9a77da5fd0\", \"cc_unittests\": \"335eda4bfe07e67225061bd0857757f56fefd82d\", \"chrome_app_unittests\": \"a830f1a4b62743b6bd03eaef92dd6654e9f25951\", \"chromedriver_unittests\": \"e9f6e8a894b578c00fc134242a27fe8305ad0430\", \"chromeos_components_unittests\": \"5302210574a9ee79e2748fd4ad821d5fa6eab54a\", \"chromeos_unittests\": \"4168ec18629292fcc82921ab916f5bbc86847c35\", \"components_browsertests\": \"15f813b32d6130c8061b41359d45fe306fcdf451\", \"components_unittests\": \"a7fd8493b8ae7795c6de095615caaeb47b075bc0\", \"compositor_unittests\": \"30d1aad744e80a3038e436b00406ef38035aba4f\", \"content_browsertests\": \"eb824a32d88cbb57043d8f111c230ed2f1943696\", \"content_unittests\": \"d1f2caf691f8641fa364fadb254bc6556824b41c\", \"crypto_unittests\": \"53f3927dec7d838f5e3101eb6bdc24f754cc742f\", \"dbus_unittests\": \"4e15d4c66aee93318e3f0cc183fef177f3b52dc3\", \"device_unittests\": \"1ee0b59a122e9bee9d9f0aee5b3905c09b38deab\", \"display_unittests\": \"d75c6bb21a02cf7303754e970838f4edf776a819\", \"events_unittests\": \"4f90db08af821f1ab92516a5df138d0c6f44c5fe\", \"exo_unittests\": \"63228bfaf96395471fef8b3ea6a3e4f18da44090\", \"extensions_browsertests\": \"d76c680a84c42022fd993d18a6ce2a1088d537f7\", \"extensions_unittests\": \"afd76f8550560ce78e82d194f5cd31ab0b628d5c\", \"filesystem_service_unittests\": \"b21ec50da0e88898b90710c4ed74dd90ce6c6194\", \"gcm_unit_tests\": \"4f92910e410035aeca8562c9c60a02cbb8bdf426\", \"gfx_unittests\": \"ab594c2b0f9543b8315ecfcaa794f73ff7b93481\", \"gin_unittests\": \"a0d3ad25ccc7ba54eadda33408317e775fa0b0f4\", \"gl_unittests_ozone\": \"5d7aa03a31098732d96ff3765ba25fee0af91681\", \"google_apis_unittests\": \"1e975c1a96a722ae7e682225ed24f6f59c789779\", \"gpu_unittests\": \"48c6f867ce529c6c1fba25aa18688f18dd5ada72\", \"interactive_ui_tests\": \"c0132c84a2dab56a2ab37dbecacdab214a818568\", \"ipc_tests\": \"f38dc8709add575b6b1cf550a6395a294c2006f9\", \"jingle_unittests\": \"d2788bb46c1bcc987a64cacf19b112b7f04dd32d\", \"keyboard_unittests\": \"15debaa8e829fc6d26658a01f4101c7c462980a0\", \"latency_unittests\": \"e78d618420de4b1ee8b2a6065e247098dc455177\", \"leveldb_service_unittests\": \"84c303e3dc010e937349255097e24626f49fa365\", \"libjingle_xmpp_unittests\": \"e457ca3cae5ef540d0c5e05b71dc94b545c74698\", \"media_blink_unittests\": \"307b0e6b3d50923aaa4f5449f8f3656162058b33\", \"media_service_unittests\": \"c8e93b71168e68a45f5550accf65f9c2dd8cdb1e\", \"media_unittests\": \"4770534a867af207fad8119644e75f7b27a1dc9e\", \"message_center_unittests\": \"fd8e7bfea08e89be574d63a1a3d351856baa18da\", \"midi_unittests\": \"f910cb48bd8cbff53b9e4300d8d8edad5995a835\", \"mojo_core_unittests\": \"f226b85b5e4fa8d4320f477b2e0082a1bff6de08\", \"mojo_unittests\": \"8e8e5765036c3bc42d5c65122c3b7a9d5a104542\", \"nacl_helper_nonsfi_unittests\": \"cf580455c3b8c5d4b503100cd414d301af5e33eb\", \"nacl_loader_unittests\": \"b3cff8030cfc83f9d10fe8196e2e12b1d8a24038\", \"native_theme_unittests\": \"2a38bb021d5eac5bfb9bf38a47df2b110167ebd7\", \"net_unittests\": \"be444a8fc2908aaf6ffee29644a06961095000a5\", \"ozone_gl_unittests\": \"03b8b3be2f236dbd3db46bfacd05f79433442263\", \"ozone_unittests\": \"3e4d3c24ff78e225254ae9f92471a98a75f5daf0\", \"ozone_x11_unittests\": \"d05a9818b55942c05c86685b091a154bd62f96ca\", \"pdf_unittests\": \"f9fe772a35d80b2ba401516f5384b091902eac7d\", \"perfetto_unittests\": \"7261b29b676a9a9bd7b0d610c2c39f7885172baa\", \"ppapi_unittests\": \"08a529ff19f3ebefd603965e3ef80e48c484a082\", \"printing_unittests\": \"bc2af797922e4652bd38a049f160178a36c122d6\", \"remoting_unittests\": \"c228fcb854f811bd1d947b4077319f82aaea3437\", \"sandbox_linux_unittests\": \"935f000c7836b3e863360a383b2e434fb914e9ea\", \"service_manager_unittests\": \"e48234c81d2bbc7b95cd2dbc5b6ffd15b8d711c5\", \"services_unittests\": \"bb82b6003907abceddf4fe5f98cb0ebd9235da34\", \"shell_dialogs_unittests\": \"6179bea213f63d77e3976aefe35f7bc50b136df5\", \"skia_unittests\": \"eeade9f16b79307d9f1f955f3d221b0cd984a318\", \"snapshot_unittests\": \"51758bc40694b7a2af6c1744fdfcb98d892e4218\", \"sql_unittests\": \"69073e97d9ce7cae811754e2f49c41770e035a92\", \"storage_unittests\": \"4fdc5a2319f7248a804ac3c82d0bc55c7f2cb1df\", \"sync_integration_tests\": \"b34604bff2f8f38d8509ce07c0784e587830c403\", \"traffic_annotation_auditor_unittests\": \"9ba505236fb54cf83a859438177e728e1a35c237\", \"ui_base_unittests\": \"5c71a6164f237f2cbdfc85850baafa07fbc34215\", \"ui_chromeos_unittests\": \"fc46a830ff0eeeb2daa50d15f4ec74e25713e54d\", \"ui_touch_selection_unittests\": \"a6b3345d2eed6dcd64eaba7011bf92f2a4461300\", \"unit_tests\": \"b596b3bc619fbd1cdbff0f0b2c5723df10af0c5d\", \"url_unittests\": \"13e1e40f36158b51b2a68ba3af415c7f89f5dc93\", \"usage_time_limit_unittests\": \"01fbec36b81e65cdbce11e381a656651614ecbeb\", \"views_unittests\": \"b9397ac7da1ee8ae2044098b5b496fa1f3a7ad61\", \"viz_unittests\": \"ef156482b87c09f91b2ae172b4dcf42bc9808a8c\", \"wm_unittests\": \"34929349ca338ac9312ace00c954035f5fbf679a\", \"wtf_unittests\": \"b08251889f64ed11cdce05894b0faa6c423fee9b\"}, \"swarm_hashes_refs/heads/master(at){#658273}_without_patch\": {\"accessibility_unittests\": \"e488edcb6cdff714eba430bda2f7c2d5298b1a66\", \"angle_unittests\": \"b0d586abe4f28fba6322d2985d9ce4db557ceada\", \"app_list_unittests\": \"c61ba6530d76a36d07d262d581dae39e57811cfc\", \"app_shell_unittests\": \"c5f5b41f17ddbaea567a8e9147bbb5a7ef513a71\", \"ash_unittests\": \"d02a86ab1c38eb88a9bb82cba7f1840237f6ce24\", \"aura_unittests\": \"f8f7c43635fdcfa614de44edd174c44a018ed421\", \"base_unittests\": \"a26230c2fdeab4872a9c3174c522e099f12336b3\", \"base_util_unittests\": \"f9b4d3b44810334bd9cd6918a0a11c401cdf0eb3\", \"blink_common_unittests\": \"dd62e3073b765d505dca6c8326ab3fcf7cbb1969\", \"blink_fuzzer_unittests\": \"42227512774b1f22ad3dbf8226735b1ea2d76de1\", \"blink_heap_unittests\": \"0b9dc2203613869e81a1f5cb56e5d5a1f2e41fc4\", \"blink_platform_unittests\": \"7117e4289dd9caab9724df56a466a4631581650d\", \"blink_unittests\": \"df1f5e138aab2881aacf5badd0f5cba580769848\", \"boringssl_crypto_tests\": \"31f7b61527601602813a6bea02818702a2ff857e\", \"boringssl_ssl_tests\": \"8371532b41c1df5c6f1d9408753af41a9a8ffe52\", \"browser_tests\": \"c98e5f301b1d78f7f6632e163254d8b675ea03e2\", \"cacheinvalidation_unittests\": \"f21051f4a2b809b0275f72d6cf8c197fb17fd2a4\", \"capture_unittests\": \"f971c1d08efa1a35fbf9f7cb9727be8c03585c40\", \"cast_unittests\": \"50cdd40f1d2409c9a4f2272f39e4dd9a77da5fd0\", \"cc_unittests\": \"335eda4bfe07e67225061bd0857757f56fefd82d\", \"chrome_app_unittests\": \"a830f1a4b62743b6bd03eaef92dd6654e9f25951\", \"chromedriver_unittests\": \"e9f6e8a894b578c00fc134242a27fe8305ad0430\", \"chromeos_components_unittests\": \"5302210574a9ee79e2748fd4ad821d5fa6eab54a\", \"chromeos_unittests\": \"4168ec18629292fcc82921ab916f5bbc86847c35\", \"components_browsertests\": \"15f813b32d6130c8061b41359d45fe306fcdf451\", \"components_unittests\": \"a7fd8493b8ae7795c6de095615caaeb47b075bc0\", \"compositor_unittests\": \"30d1aad744e80a3038e436b00406ef38035aba4f\", \"content_browsertests\": \"eb824a32d88cbb57043d8f111c230ed2f1943696\", \"content_unittests\": \"d1f2caf691f8641fa364fadb254bc6556824b41c\", \"crypto_unittests\": \"53f3927dec7d838f5e3101eb6bdc24f754cc742f\", \"dbus_unittests\": \"4e15d4c66aee93318e3f0cc183fef177f3b52dc3\", \"device_unittests\": \"1ee0b59a122e9bee9d9f0aee5b3905c09b38deab\", \"display_unittests\": \"d75c6bb21a02cf7303754e970838f4edf776a819\", \"events_unittests\": \"4f90db08af821f1ab92516a5df138d0c6f44c5fe\", \"exo_unittests\": \"63228bfaf96395471fef8b3ea6a3e4f18da44090\", \"extensions_browsertests\": \"d76c680a84c42022fd993d18a6ce2a1088d537f7\", \"extensions_unittests\": \"afd76f8550560ce78e82d194f5cd31ab0b628d5c\", \"filesystem_service_unittests\": \"b21ec50da0e88898b90710c4ed74dd90ce6c6194\", \"gcm_unit_tests\": \"4f92910e410035aeca8562c9c60a02cbb8bdf426\", \"gfx_unittests\": \"ab594c2b0f9543b8315ecfcaa794f73ff7b93481\", \"gin_unittests\": \"a0d3ad25ccc7ba54eadda33408317e775fa0b0f4\", \"gl_unittests_ozone\": \"5d7aa03a31098732d96ff3765ba25fee0af91681\", \"google_apis_unittests\": \"1e975c1a96a722ae7e682225ed24f6f59c789779\", \"gpu_unittests\": \"48c6f867ce529c6c1fba25aa18688f18dd5ada72\", \"interactive_ui_tests\": \"c0132c84a2dab56a2ab37dbecacdab214a818568\", \"ipc_tests\": \"f38dc8709add575b6b1cf550a6395a294c2006f9\", \"jingle_unittests\": \"d2788bb46c1bcc987a64cacf19b112b7f04dd32d\", \"keyboard_unittests\": \"15debaa8e829fc6d26658a01f4101c7c462980a0\", \"latency_unittests\": \"e78d618420de4b1ee8b2a6065e247098dc455177\", \"leveldb_service_unittests\": \"84c303e3dc010e937349255097e24626f49fa365\", \"libjingle_xmpp_unittests\": \"e457ca3cae5ef540d0c5e05b71dc94b545c74698\", \"media_blink_unittests\": \"307b0e6b3d50923aaa4f5449f8f3656162058b33\", \"media_service_unittests\": \"c8e93b71168e68a45f5550accf65f9c2dd8cdb1e\", \"media_unittests\": \"4770534a867af207fad8119644e75f7b27a1dc9e\", \"message_center_unittests\": \"fd8e7bfea08e89be574d63a1a3d351856baa18da\", \"midi_unittests\": \"f910cb48bd8cbff53b9e4300d8d8edad5995a835\", \"mojo_core_unittests\": \"f226b85b5e4fa8d4320f477b2e0082a1bff6de08\", \"mojo_unittests\": \"8e8e5765036c3bc42d5c65122c3b7a9d5a104542\", \"nacl_helper_nonsfi_unittests\": \"cf580455c3b8c5d4b503100cd414d301af5e33eb\", \"nacl_loader_unittests\": \"b3cff8030cfc83f9d10fe8196e2e12b1d8a24038\", \"native_theme_unittests\": \"2a38bb021d5eac5bfb9bf38a47df2b110167ebd7\", \"net_unittests\": \"be444a8fc2908aaf6ffee29644a06961095000a5\", \"ozone_gl_unittests\": \"03b8b3be2f236dbd3db46bfacd05f79433442263\", \"ozone_unittests\": \"3e4d3c24ff78e225254ae9f92471a98a75f5daf0\", \"ozone_x11_unittests\": \"d05a9818b55942c05c86685b091a154bd62f96ca\", \"pdf_unittests\": \"f9fe772a35d80b2ba401516f5384b091902eac7d\", \"perfetto_unittests\": \"7261b29b676a9a9bd7b0d610c2c39f7885172baa\", \"ppapi_unittests\": \"08a529ff19f3ebefd603965e3ef80e48c484a082\", \"printing_unittests\": \"bc2af797922e4652bd38a049f160178a36c122d6\", \"remoting_unittests\": \"c228fcb854f811bd1d947b4077319f82aaea3437\", \"sandbox_linux_unittests\": \"935f000c7836b3e863360a383b2e434fb914e9ea\", \"service_manager_unittests\": \"e48234c81d2bbc7b95cd2dbc5b6ffd15b8d711c5\", \"services_unittests\": \"bb82b6003907abceddf4fe5f98cb0ebd9235da34\", \"shell_dialogs_unittests\": \"6179bea213f63d77e3976aefe35f7bc50b136df5\", \"skia_unittests\": \"eeade9f16b79307d9f1f955f3d221b0cd984a318\", \"snapshot_unittests\": \"51758bc40694b7a2af6c1744fdfcb98d892e4218\", \"sql_unittests\": \"69073e97d9ce7cae811754e2f49c41770e035a92\", \"storage_unittests\": \"4fdc5a2319f7248a804ac3c82d0bc55c7f2cb1df\", \"sync_integration_tests\": \"b34604bff2f8f38d8509ce07c0784e587830c403\", \"traffic_annotation_auditor_unittests\": \"9ba505236fb54cf83a859438177e728e1a35c237\", \"ui_base_unittests\": \"5c71a6164f237f2cbdfc85850baafa07fbc34215\", \"ui_chromeos_unittests\": \"fc46a830ff0eeeb2daa50d15f4ec74e25713e54d\", \"ui_touch_selection_unittests\": \"a6b3345d2eed6dcd64eaba7011bf92f2a4461300\", \"unit_tests\": \"b596b3bc619fbd1cdbff0f0b2c5723df10af0c5d\", \"url_unittests\": \"13e1e40f36158b51b2a68ba3af415c7f89f5dc93\", \"usage_time_limit_unittests\": \"01fbec36b81e65cdbce11e381a656651614ecbeb\", \"views_unittests\": \"b9397ac7da1ee8ae2044098b5b496fa1f3a7ad61\", \"viz_unittests\": \"ef156482b87c09f91b2ae172b4dcf42bc9808a8c\", \"wm_unittests\": \"34929349ca338ac9312ace00c954035f5fbf679a\", \"wtf_unittests\": \"b08251889f64ed11cdce05894b0faa6c423fee9b\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4292-d8c05fa\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557436535649209",
"status": "COMPLETED",
"status_changed_ts": "1557442431824521",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12301",
"builder:linux-chromeos-dbg",
"buildset:commit/git/052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/052cdd262b0a9cbd2fa000bfc0b2c3e9cbf3f731",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079333220137208800",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8913903154144059424/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:44b7450532944510",
"user_agent:luci-scheduler"
],
"updated_ts": "1557442431827797",
"url": "https://ci.chromium.org/b/8913903154144059424",
"utcnow_ts": "1557442434884341"
}
}
[22:53:54.898] Invocation finished in 1h38m34.82824657s with status SUCCEEDED