[14:01:05.252] New invocation is queued and will start shortly
[14:01:06.795] Starting the invocation (attempt 1)
[14:01:06.847] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:01:06.847] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:01:06.847] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9024186988082509872",
"parameters_json": "{\"builder_name\":\"linux-run-on-app-dump\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"91fb5f2a582f336140a9c883a4dc4e310466f6b2\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@91fb5f2a582f336140a9c883a4dc4e310466f6b2\",\"title\":\"91fb5f2a582f336140a9c883a4dc4e310466f6b2\",\"url\":\"https://r8.googlesource.com/r8/+/91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-run-on-app-dump",
"scheduler_invocation_id:9024186988082509872",
"scheduler_job_id:r8/linux-run-on-app-dump",
"user_agent:luci-scheduler",
"buildset:commit/git/91fb5f2a582f336140a9c883a4dc4e310466f6b2",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/91fb5f2a582f336140a9c883a4dc4e310466f6b2",
"gitiles_ref:refs/heads/master"
]
}
[14:01:07.737] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:r8",
"created_ts": "1610028066993333",
"id": "8858756925583363360",
"parameters_json": "{\"builder_name\": \"linux-run-on-app-dump\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@91fb5f2a582f336140a9c883a4dc4e310466f6b2\", \"title\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\", \"url\": \"https://r8.googlesource.com/r8/+/91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610028067562718",
"tags": [
"build_address:luci.r8.ci/linux-run-on-app-dump/268",
"builder:linux-run-on-app-dump",
"buildset:commit/git/91fb5f2a582f336140a9c883a4dc4e310466f6b2",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/91fb5f2a582f336140a9c883a4dc4e310466f6b2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024186988082509872",
"scheduler_job_id:r8/linux-run-on-app-dump",
"swarming_hostname:chrome-swarming.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8858756925583363360/+/annotations",
"swarming_tag:luci_project:r8",
"swarming_tag:recipe_name:rex",
"swarming_tag:recipe_package:infra_internal/recipe_bundles/chrome-internal.googlesource.com/chrome/tools/build_limited/scripts/slave",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1610028067562828",
"url": "https://ci.chromium.org/b/8858756925583363360",
"utcnow_ts": "1610028067727890"
}
}
[14:01:07.737] Task URL: https://ci.chromium.org/b/8858756925583363360
[14:01:07.737] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:2:0) after 1m0s
[14:01:26.452] Received PubSub notification, asking Buildbucket for the build status
[14:01:26.650] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:07.808] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:2:0)
[14:02:07.808] Timer tick, asking Buildbucket for the build status
[14:02:07.972] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:07.972] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:4:0) after 1m0s
[14:03:07.989] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:4:0)
[14:03:07.989] Timer tick, asking Buildbucket for the build status
[14:03:08.046] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:08.046] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:5:0) after 1m0s
[14:04:08.083] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:5:0)
[14:04:08.083] Timer tick, asking Buildbucket for the build status
[14:04:08.261] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:08.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:6:0) after 1m0s
[14:05:08.270] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:6:0)
[14:05:08.270] Timer tick, asking Buildbucket for the build status
[14:05:08.472] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:08.472] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:7:0) after 1m0s
[14:06:08.498] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:7:0)
[14:06:08.498] Timer tick, asking Buildbucket for the build status
[14:06:08.560] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:08.560] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:8:0) after 1m0s
[14:07:08.579] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:8:0)
[14:07:08.579] Timer tick, asking Buildbucket for the build status
[14:07:08.981] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:08.981] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:9:0) after 1m0s
[14:08:09.026] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:9:0)
[14:08:09.026] Timer tick, asking Buildbucket for the build status
[14:08:09.098] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:09.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:10:0) after 1m0s
[14:09:09.093] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:10:0)
[14:09:09.093] Timer tick, asking Buildbucket for the build status
[14:09:09.397] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:09.397] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:11:0) after 1m0s
[14:10:09.416] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:11:0)
[14:10:09.416] Timer tick, asking Buildbucket for the build status
[14:10:09.487] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:09.487] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:12:0) after 1m0s
[14:11:09.510] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:12:0)
[14:11:09.510] Timer tick, asking Buildbucket for the build status
[14:11:09.608] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:09.608] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:13:0) after 1m0s
[14:12:09.631] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:13:0)
[14:12:09.631] Timer tick, asking Buildbucket for the build status
[14:12:09.985] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:09.985] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:14:0) after 1m0s
[14:13:10.006] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:14:0)
[14:13:10.006] Timer tick, asking Buildbucket for the build status
[14:13:10.072] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:10.072] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:15:0) after 1m0s
[14:14:10.093] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:15:0)
[14:14:10.093] Timer tick, asking Buildbucket for the build status
[14:14:10.197] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:10.198] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:16:0) after 1m0s
[14:15:10.247] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:16:0)
[14:15:10.247] Timer tick, asking Buildbucket for the build status
[14:15:14.879] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:14.879] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:17:0) after 1m0s
[14:16:14.962] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:17:0)
[14:16:14.962] Timer tick, asking Buildbucket for the build status
[14:16:15.165] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:15.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:18:0) after 1m0s
[14:17:15.237] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:18:0)
[14:17:15.237] Timer tick, asking Buildbucket for the build status
[14:17:15.358] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:15.358] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:19:0) after 1m0s
[14:18:15.440] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:19:0)
[14:18:15.443] Timer tick, asking Buildbucket for the build status
[14:18:15.525] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:15.525] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:20:0) after 1m0s
[14:19:15.544] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:20:0)
[14:19:15.544] Timer tick, asking Buildbucket for the build status
[14:19:15.598] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:15.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:21:0) after 1m0s
[14:20:15.640] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:21:0)
[14:20:15.641] Timer tick, asking Buildbucket for the build status
[14:20:15.700] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:15.700] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:22:0) after 1m0s
[14:21:15.950] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:22:0)
[14:21:15.950] Timer tick, asking Buildbucket for the build status
[14:21:16.015] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:16.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:23:0) after 1m0s
[14:22:16.204] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:23:0)
[14:22:16.204] Timer tick, asking Buildbucket for the build status
[14:22:16.332] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:16.332] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:24:0) after 1m0s
[14:23:16.361] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:24:0)
[14:23:16.361] Timer tick, asking Buildbucket for the build status
[14:23:16.483] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:16.483] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:25:0) after 1m0s
[14:24:16.599] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:25:0)
[14:24:16.599] Timer tick, asking Buildbucket for the build status
[14:24:16.802] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:16.802] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:26:0) after 1m0s
[14:25:16.875] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:26:0)
[14:25:16.875] Timer tick, asking Buildbucket for the build status
[14:25:16.966] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:16.966] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:27:0) after 1m0s
[14:26:17.070] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:27:0)
[14:26:17.070] Timer tick, asking Buildbucket for the build status
[14:26:17.164] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:17.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:28:0) after 1m0s
[14:27:17.313] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:28:0)
[14:27:17.313] Timer tick, asking Buildbucket for the build status
[14:27:17.810] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:17.811] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:29:0) after 1m0s
[14:28:17.975] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:29:0)
[14:28:17.975] Timer tick, asking Buildbucket for the build status
[14:28:18.066] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:18.066] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:30:0) after 1m0s
[14:29:18.217] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:30:0)
[14:29:18.217] Timer tick, asking Buildbucket for the build status
[14:29:18.372] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:18.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:31:0) after 1m0s
[14:30:18.428] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:31:0)
[14:30:18.428] Timer tick, asking Buildbucket for the build status
[14:30:18.476] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:18.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:32:0) after 1m0s
[14:31:19.696] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:32:0)
[14:31:19.696] Timer tick, asking Buildbucket for the build status
[14:31:19.854] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:19.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:33:0) after 1m0s
[14:32:20.131] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:33:0)
[14:32:20.131] Timer tick, asking Buildbucket for the build status
[14:32:20.468] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:20.468] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:34:0) after 1m0s
[14:33:20.500] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:34:0)
[14:33:20.500] Timer tick, asking Buildbucket for the build status
[14:33:20.558] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:20.558] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:35:0) after 1m0s
[14:34:20.594] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:35:0)
[14:34:20.594] Timer tick, asking Buildbucket for the build status
[14:34:20.751] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:20.751] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:36:0) after 1m0s
[14:35:20.894] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:36:0)
[14:35:20.894] Timer tick, asking Buildbucket for the build status
[14:35:21.148] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:21.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:37:0) after 1m0s
[14:36:21.167] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:37:0)
[14:36:21.167] Timer tick, asking Buildbucket for the build status
[14:36:21.257] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:21.257] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:38:0) after 1m0s
[14:37:21.308] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:38:0)
[14:37:21.308] Timer tick, asking Buildbucket for the build status
[14:37:21.722] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:21.722] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:39:0) after 1m0s
[14:38:21.747] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:39:0)
[14:38:21.747] Timer tick, asking Buildbucket for the build status
[14:38:21.826] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:21.826] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:40:0) after 1m0s
[14:39:21.886] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:40:0)
[14:39:21.886] Timer tick, asking Buildbucket for the build status
[14:39:21.952] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:21.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:41:0) after 1m0s
[14:40:22.077] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:41:0)
[14:40:22.077] Timer tick, asking Buildbucket for the build status
[14:40:22.316] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:22.316] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:42:0) after 1m0s
[14:41:22.472] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:42:0)
[14:41:22.472] Timer tick, asking Buildbucket for the build status
[14:41:22.556] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:22.556] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:43:0) after 1m0s
[14:42:22.672] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:43:0)
[14:42:22.672] Timer tick, asking Buildbucket for the build status
[14:42:25.471] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:25.471] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:44:0) after 1m0s
[14:43:25.701] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:44:0)
[14:43:25.701] Timer tick, asking Buildbucket for the build status
[14:43:25.787] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:25.787] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:45:0) after 1m0s
[14:44:25.938] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:45:0)
[14:44:25.938] Timer tick, asking Buildbucket for the build status
[14:44:26.081] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:26.081] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:46:0) after 1m0s
[14:45:26.119] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:46:0)
[14:45:26.119] Timer tick, asking Buildbucket for the build status
[14:45:26.179] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:26.179] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:47:0) after 1m0s
[14:46:26.228] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:47:0)
[14:46:26.228] Timer tick, asking Buildbucket for the build status
[14:46:26.547] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:26.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:48:0) after 1m0s
[14:47:26.607] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:48:0)
[14:47:26.607] Timer tick, asking Buildbucket for the build status
[14:47:26.906] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:26.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:49:0) after 1m0s
[14:48:27.041] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:49:0)
[14:48:27.041] Timer tick, asking Buildbucket for the build status
[14:48:27.245] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:27.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:50:0) after 1m0s
[14:49:27.329] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:50:0)
[14:49:27.329] Timer tick, asking Buildbucket for the build status
[14:49:27.381] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:27.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:51:0) after 1m0s
[14:50:27.440] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:51:0)
[14:50:27.440] Timer tick, asking Buildbucket for the build status
[14:50:27.524] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:27.524] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:52:0) after 1m0s
[14:51:27.613] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:52:0)
[14:51:27.613] Timer tick, asking Buildbucket for the build status
[14:51:27.688] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:27.688] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:53:0) after 1m0s
[14:52:27.730] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:53:0)
[14:52:27.730] Timer tick, asking Buildbucket for the build status
[14:52:29.838] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:29.838] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:54:0) after 1m0s
[14:53:29.953] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:54:0)
[14:53:29.953] Timer tick, asking Buildbucket for the build status
[14:53:30.024] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:30.024] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:55:0) after 1m0s
[14:54:30.082] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:55:0)
[14:54:30.082] Timer tick, asking Buildbucket for the build status
[14:54:30.277] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:30.277] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:56:0) after 1m0s
[14:55:30.297] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:56:0)
[14:55:30.297] Timer tick, asking Buildbucket for the build status
[14:55:30.385] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:30.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:57:0) after 1m0s
[14:56:30.418] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:57:0)
[14:56:30.418] Timer tick, asking Buildbucket for the build status
[14:56:30.520] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:30.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:58:0) after 1m0s
[14:57:30.570] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:58:0)
[14:57:30.570] Timer tick, asking Buildbucket for the build status
[14:57:30.645] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:30.645] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:59:0) after 1m0s
[14:58:30.706] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:59:0)
[14:58:30.706] Timer tick, asking Buildbucket for the build status
[14:58:30.967] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:30.967] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:60:0) after 1m0s
[14:59:31.063] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:60:0)
[14:59:31.063] Timer tick, asking Buildbucket for the build status
[14:59:31.136] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:31.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:61:0) after 1m0s
[15:00:31.141] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:61:0)
[15:00:31.141] Timer tick, asking Buildbucket for the build status
[15:00:31.218] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:31.218] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:62:0) after 1m0s
[15:01:31.269] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:62:0)
[15:01:31.270] Timer tick, asking Buildbucket for the build status
[15:01:31.457] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:31.457] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:63:0) after 1m0s
[15:02:31.630] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:63:0)
[15:02:31.630] Timer tick, asking Buildbucket for the build status
[15:02:31.712] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:31.712] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:64:0) after 1m0s
[15:03:31.799] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:64:0)
[15:03:31.799] Timer tick, asking Buildbucket for the build status
[15:03:32.162] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:32.162] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:65:0) after 1m0s
[15:04:32.325] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:65:0)
[15:04:32.325] Timer tick, asking Buildbucket for the build status
[15:04:32.385] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:32.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:66:0) after 1m0s
[15:05:32.484] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:66:0)
[15:05:32.484] Timer tick, asking Buildbucket for the build status
[15:05:32.595] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:32.595] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:67:0) after 1m0s
[15:06:32.652] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:67:0)
[15:06:32.652] Timer tick, asking Buildbucket for the build status
[15:06:33.107] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:33.107] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:68:0) after 1m0s
[15:07:33.258] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:68:0)
[15:07:33.258] Timer tick, asking Buildbucket for the build status
[15:07:33.339] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:33.339] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:69:0) after 1m0s
[15:08:33.408] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:69:0)
[15:08:33.408] Timer tick, asking Buildbucket for the build status
[15:08:33.474] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:33.474] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:70:0) after 1m0s
[15:09:33.505] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:70:0)
[15:09:33.505] Timer tick, asking Buildbucket for the build status
[15:09:33.575] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:33.575] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:71:0) after 1m0s
[15:10:33.635] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:71:0)
[15:10:33.635] Timer tick, asking Buildbucket for the build status
[15:10:33.910] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:33.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:72:0) after 1m0s
[15:11:33.941] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:72:0)
[15:11:33.941] Timer tick, asking Buildbucket for the build status
[15:11:34.362] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:34.362] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:73:0) after 1m0s
[15:12:34.502] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:73:0)
[15:12:34.502] Timer tick, asking Buildbucket for the build status
[15:12:34.691] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:34.691] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:74:0) after 1m0s
[15:13:34.790] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:74:0)
[15:13:34.790] Timer tick, asking Buildbucket for the build status
[15:13:34.889] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:34.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:75:0) after 1m0s
[15:14:35.003] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:75:0)
[15:14:35.003] Timer tick, asking Buildbucket for the build status
[15:14:36.183] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:36.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:76:0) after 1m0s
[15:15:36.224] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:76:0)
[15:15:36.224] Timer tick, asking Buildbucket for the build status
[15:15:36.297] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:36.297] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:77:0) after 1m0s
[15:16:36.317] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:77:0)
[15:16:36.317] Timer tick, asking Buildbucket for the build status
[15:16:36.421] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:36.421] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:78:0) after 1m0s
[15:17:36.516] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:78:0)
[15:17:36.516] Timer tick, asking Buildbucket for the build status
[15:17:36.575] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:36.575] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:79:0) after 1m0s
[15:18:36.608] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:79:0)
[15:18:36.608] Timer tick, asking Buildbucket for the build status
[15:18:36.684] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:36.684] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:80:0) after 1m0s
[15:19:36.768] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:80:0)
[15:19:36.768] Timer tick, asking Buildbucket for the build status
[15:19:36.834] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:36.834] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:81:0) after 1m0s
[15:20:36.876] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:81:0)
[15:20:36.876] Timer tick, asking Buildbucket for the build status
[15:20:37.245] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:37.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:82:0) after 1m0s
[15:21:37.296] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:82:0)
[15:21:37.296] Timer tick, asking Buildbucket for the build status
[15:21:37.466] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:37.466] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:83:0) after 1m0s
[15:22:37.518] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:83:0)
[15:22:37.518] Timer tick, asking Buildbucket for the build status
[15:22:37.730] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:37.730] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:84:0) after 1m0s
[15:23:37.813] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:84:0)
[15:23:37.813] Timer tick, asking Buildbucket for the build status
[15:23:37.919] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:37.919] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:85:0) after 1m0s
[15:24:38.112] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:85:0)
[15:24:38.112] Timer tick, asking Buildbucket for the build status
[15:24:38.184] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:38.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:86:0) after 1m0s
[15:25:38.252] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:86:0)
[15:25:38.252] Timer tick, asking Buildbucket for the build status
[15:25:38.309] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:38.309] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:87:0) after 1m0s
[15:26:38.410] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:87:0)
[15:26:38.410] Timer tick, asking Buildbucket for the build status
[15:26:38.523] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:38.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:88:0) after 1m0s
[15:27:38.604] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:88:0)
[15:27:38.604] Timer tick, asking Buildbucket for the build status
[15:27:39.002] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:39.003] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:89:0) after 1m0s
[15:28:39.063] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:89:0)
[15:28:39.063] Timer tick, asking Buildbucket for the build status
[15:28:39.146] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:39.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:90:0) after 1m0s
[15:29:39.141] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:90:0)
[15:29:39.141] Timer tick, asking Buildbucket for the build status
[15:29:39.256] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:39.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:91:0) after 1m0s
[15:30:39.410] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:91:0)
[15:30:39.410] Timer tick, asking Buildbucket for the build status
[15:30:39.486] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:39.486] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:92:0) after 1m0s
[15:31:39.516] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:92:0)
[15:31:39.516] Timer tick, asking Buildbucket for the build status
[15:31:39.983] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:39.983] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:93:0) after 1m0s
[15:32:40.057] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:93:0)
[15:32:40.057] Timer tick, asking Buildbucket for the build status
[15:32:40.128] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:40.128] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:94:0) after 1m0s
[15:33:40.110] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:94:0)
[15:33:40.110] Timer tick, asking Buildbucket for the build status
[15:33:40.183] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:40.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:95:0) after 1m0s
[15:34:40.443] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:95:0)
[15:34:40.443] Timer tick, asking Buildbucket for the build status
[15:34:40.607] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:40.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:96:0) after 1m0s
[15:35:40.690] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:96:0)
[15:35:40.690] Timer tick, asking Buildbucket for the build status
[15:35:40.800] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:40.800] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:97:0) after 1m0s
[15:36:40.828] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:97:0)
[15:36:40.828] Timer tick, asking Buildbucket for the build status
[15:36:40.963] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:40.963] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:98:0) after 1m0s
[15:37:40.986] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:98:0)
[15:37:40.986] Timer tick, asking Buildbucket for the build status
[15:37:41.220] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:41.220] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:99:0) after 1m0s
[15:38:41.273] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:99:0)
[15:38:41.273] Timer tick, asking Buildbucket for the build status
[15:38:41.336] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:41.336] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:100:0) after 1m0s
[15:39:41.382] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:100:0)
[15:39:41.382] Timer tick, asking Buildbucket for the build status
[15:39:41.630] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:41.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:101:0) after 1m0s
[15:40:41.693] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:101:0)
[15:40:41.694] Timer tick, asking Buildbucket for the build status
[15:40:41.979] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:41.979] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:102:0) after 1m0s
[15:41:42.195] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:102:0)
[15:41:42.195] Timer tick, asking Buildbucket for the build status
[15:41:42.377] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:42.377] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:103:0) after 1m0s
[15:42:42.586] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:103:0)
[15:42:42.586] Timer tick, asking Buildbucket for the build status
[15:42:43.752] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:43.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:104:0) after 1m0s
[15:43:43.847] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:104:0)
[15:43:43.847] Timer tick, asking Buildbucket for the build status
[15:43:43.947] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:43.947] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:105:0) after 1m0s
[15:44:44.467] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:105:0)
[15:44:44.467] Timer tick, asking Buildbucket for the build status
[15:44:44.867] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:44.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:106:0) after 1m0s
[15:45:44.974] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:106:0)
[15:45:44.974] Timer tick, asking Buildbucket for the build status
[15:45:45.041] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:45.041] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:107:0) after 1m0s
[15:46:45.063] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:107:0)
[15:46:45.063] Timer tick, asking Buildbucket for the build status
[15:46:45.170] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:45.170] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:108:0) after 1m0s
[15:47:45.242] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:108:0)
[15:47:45.242] Timer tick, asking Buildbucket for the build status
[15:47:45.423] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:45.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:109:0) after 1m0s
[15:48:45.430] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:109:0)
[15:48:45.430] Timer tick, asking Buildbucket for the build status
[15:48:45.619] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:45.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:110:0) after 1m0s
[15:49:45.677] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:110:0)
[15:49:45.677] Timer tick, asking Buildbucket for the build status
[15:49:45.906] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:45.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:111:0) after 1m0s
[15:50:45.898] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:111:0)
[15:50:45.898] Timer tick, asking Buildbucket for the build status
[15:50:46.156] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:46.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:112:0) after 1m0s
[15:51:46.178] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:112:0)
[15:51:46.178] Timer tick, asking Buildbucket for the build status
[15:51:46.337] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:46.338] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:113:0) after 1m0s
[15:52:46.374] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:113:0)
[15:52:46.374] Timer tick, asking Buildbucket for the build status
[15:52:46.490] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:46.490] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:114:0) after 1m0s
[15:53:46.523] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:114:0)
[15:53:46.523] Timer tick, asking Buildbucket for the build status
[15:53:46.836] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:46.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:115:0) after 1m0s
[15:54:46.943] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:115:0)
[15:54:46.943] Timer tick, asking Buildbucket for the build status
[15:54:47.051] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:47.051] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:116:0) after 1m0s
[15:55:47.163] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:116:0)
[15:55:47.163] Timer tick, asking Buildbucket for the build status
[15:55:47.235] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:47.235] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:117:0) after 1m0s
[15:56:47.362] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:117:0)
[15:56:47.362] Timer tick, asking Buildbucket for the build status
[15:56:47.491] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:47.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:118:0) after 1m0s
[15:57:47.589] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:118:0)
[15:57:47.589] Timer tick, asking Buildbucket for the build status
[15:57:47.732] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:47.732] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:119:0) after 1m0s
[15:58:47.785] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:119:0)
[15:58:47.785] Timer tick, asking Buildbucket for the build status
[15:58:47.893] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:47.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:120:0) after 1m0s
[15:59:47.939] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:120:0)
[15:59:47.939] Timer tick, asking Buildbucket for the build status
[15:59:48.207] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:48.207] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:121:0) after 1m0s
[16:00:48.249] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:121:0)
[16:00:48.249] Timer tick, asking Buildbucket for the build status
[16:00:48.416] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:48.416] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:122:0) after 1m0s
[16:01:48.454] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:122:0)
[16:01:48.454] Timer tick, asking Buildbucket for the build status
[16:01:48.559] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:48.559] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:123:0) after 1m0s
[16:02:48.629] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:123:0)
[16:02:48.629] Timer tick, asking Buildbucket for the build status
[16:02:48.787] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:48.787] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:124:0) after 1m0s
[16:03:48.833] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:124:0)
[16:03:48.833] Timer tick, asking Buildbucket for the build status
[16:03:48.898] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:48.898] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:125:0) after 1m0s
[16:04:48.937] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:125:0)
[16:04:48.937] Timer tick, asking Buildbucket for the build status
[16:04:49.039] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:49.039] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:126:0) after 1m0s
[16:05:49.105] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:126:0)
[16:05:49.105] Timer tick, asking Buildbucket for the build status
[16:05:49.284] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:49.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:127:0) after 1m0s
[16:06:49.331] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:127:0)
[16:06:49.331] Timer tick, asking Buildbucket for the build status
[16:06:49.712] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:49.712] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:128:0) after 1m0s
[16:07:49.793] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:128:0)
[16:07:49.793] Timer tick, asking Buildbucket for the build status
[16:07:49.852] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:49.852] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:129:0) after 1m0s
[16:08:49.922] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:129:0)
[16:08:49.922] Timer tick, asking Buildbucket for the build status
[16:08:50.074] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:50.074] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:130:0) after 1m0s
[16:09:50.054] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:130:0)
[16:09:50.054] Timer tick, asking Buildbucket for the build status
[16:09:50.176] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:50.176] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:131:0) after 1m0s
[16:10:50.245] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:131:0)
[16:10:50.245] Timer tick, asking Buildbucket for the build status
[16:10:50.554] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:50.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:132:0) after 1m0s
[16:11:50.679] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:132:0)
[16:11:50.679] Timer tick, asking Buildbucket for the build status
[16:11:52.534] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:52.534] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:133:0) after 1m0s
[16:12:52.614] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:133:0)
[16:12:52.614] Timer tick, asking Buildbucket for the build status
[16:12:52.685] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:52.685] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:134:0) after 1m0s
[16:13:52.713] Handling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:134:0)
[16:13:52.713] Timer tick, asking Buildbucket for the build status
[16:13:52.807] Build 8858756925583363360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:52.807] Scheduling timer "check-buildbucket-build-status" (r8/linux-run-on-app-dump:9024186988082509872:135:0) after 1m0s
[16:14:12.108] Received PubSub notification, asking Buildbucket for the build status
[16:14:12.185] Build 8858756925583363360: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:14:12.186] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1610036051222779",
"created_by": "project:r8",
"created_ts": "1610028066993333",
"id": "8858756925583363360",
"parameters_json": "{\"builder_name\": \"linux-run-on-app-dump\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@91fb5f2a582f336140a9c883a4dc4e310466f6b2\", \"title\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\", \"url\": \"https://r8.googlesource.com/r8/+/91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}}",
"project": "r8",
"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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@91fb5f2a582f336140a9c883a4dc4e310466f6b2\", \"title\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\", \"url\": \"https://r8.googlesource.com/r8/+/91fb5f2a582f336140a9c883a4dc4e310466f6b2\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-15-h392\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-run-on-app-dump\", \"buildnumber\": 268, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"91fb5f2a582f336140a9c883a4dc4e310466f6b2\", \"test_options\": [\"--bot\"], \"test_wrapper\": \"tools/run_on_app_dump.py\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_2fe974aa3aff6714e29343e9511f6f9d336474a98278f3ae903e122358e38a85_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"r8bot-265908\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-custom-ci-xenial-15-h392\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"normal\": [\"true\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.r8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610028084610328",
"status": "COMPLETED",
"status_changed_ts": "1610036051470608",
"tags": [
"build_address:luci.r8.ci/linux-run-on-app-dump/268",
"builder:linux-run-on-app-dump",
"buildset:commit/git/91fb5f2a582f336140a9c883a4dc4e310466f6b2",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/91fb5f2a582f336140a9c883a4dc4e310466f6b2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024186988082509872",
"scheduler_job_id:r8/linux-run-on-app-dump",
"swarming_hostname:chrome-swarming.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8858756925583363360/+/annotations",
"swarming_tag:luci_project:r8",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:rex",
"swarming_tag:recipe_package:infra_internal/recipe_bundles/chrome-internal.googlesource.com/chrome/tools/build_limited/scripts/slave",
"swarming_task_id:50f5f8349041f610",
"user_agent:luci-scheduler"
],
"updated_ts": "1610036051481339",
"url": "https://ci.chromium.org/b/8858756925583363360",
"utcnow_ts": "1610036052177268"
}
}
[16:14:12.186] Invocation finished in 2h13m6.959458535s with status SUCCEEDED