[21:39:18.779] New invocation is queued and will start shortly
[21:39:20.278] Starting the invocation (attempt 1)
[21:39:20.320] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:39:20.321] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:39:20.321] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077066787457275792",
"parameters_json": "{\"builder_name\":\"Deterministic Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"178575e5c2a0fcaf566d5e39a60b65847b59d2ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android",
"scheduler_invocation_id:9077066787457275792",
"scheduler_job_id:chromium/Deterministic Android",
"user_agent:luci-scheduler",
"buildset:commit/git/178575e5c2a0fcaf566d5e39a60b65847b59d2ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/178575e5c2a0fcaf566d5e39a60b65847b59d2ee",
"gitiles_ref:refs/heads/master"
]
}
[21:39:21.474] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559597960587706",
"experimental": true,
"id": "8911636724837554608",
"parameters_json": "{\"builder_name\": \"Deterministic Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"178575e5c2a0fcaf566d5e39a60b65847b59d2ee\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559597961241741",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android/5340",
"builder:Deterministic Android",
"buildset:commit/git/178575e5c2a0fcaf566d5e39a60b65847b59d2ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/178575e5c2a0fcaf566d5e39a60b65847b59d2ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077066787457275792",
"scheduler_job_id:chromium/Deterministic Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8911636724837554608/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1559597961241860",
"url": "https://ci.chromium.org/b/8911636724837554608",
"utcnow_ts": "1559597961463120"
}
}
[21:39:21.474] Task URL: https://ci.chromium.org/b/8911636724837554608
[21:39:21.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:2:0) after 1m0s
[21:40:05.018] Received PubSub notification, asking Buildbucket for the build status
[21:40:05.216] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:21.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:2:0)
[21:40:21.463] Timer tick, asking Buildbucket for the build status
[21:40:22.382] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:22.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:4:0) after 1m0s
[21:41:22.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:4:0)
[21:41:22.449] Timer tick, asking Buildbucket for the build status
[21:41:22.724] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:22.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:5:0) after 1m0s
[21:42:22.882] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:5:0)
[21:42:22.882] Timer tick, asking Buildbucket for the build status
[21:42:22.993] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:22.993] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:6:0) after 1m0s
[21:43:23.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:6:0)
[21:43:23.101] Timer tick, asking Buildbucket for the build status
[21:43:23.238] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:23.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:7:0) after 1m0s
[21:44:23.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:7:0)
[21:44:23.275] Timer tick, asking Buildbucket for the build status
[21:44:23.431] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:23.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:8:0) after 1m0s
[21:45:23.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:8:0)
[21:45:23.492] Timer tick, asking Buildbucket for the build status
[21:45:23.754] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:23.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:9:0) after 1m0s
[21:46:23.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:9:0)
[21:46:23.775] Timer tick, asking Buildbucket for the build status
[21:46:24.219] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:24.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:10:0) after 1m0s
[21:47:24.243] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:10:0)
[21:47:24.243] Timer tick, asking Buildbucket for the build status
[21:47:24.581] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:24.581] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:11:0) after 1m0s
[21:48:24.602] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:11:0)
[21:48:24.602] Timer tick, asking Buildbucket for the build status
[21:48:25.697] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:25.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:12:0) after 1m0s
[21:49:25.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:12:0)
[21:49:25.743] Timer tick, asking Buildbucket for the build status
[21:49:26.109] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:26.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:13:0) after 1m0s
[21:50:26.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:13:0)
[21:50:26.133] Timer tick, asking Buildbucket for the build status
[21:50:26.671] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:26.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:14:0) after 1m0s
[21:51:26.712] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:14:0)
[21:51:26.712] Timer tick, asking Buildbucket for the build status
[21:51:27.297] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:27.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:15:0) after 1m0s
[21:52:27.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:15:0)
[21:52:27.340] Timer tick, asking Buildbucket for the build status
[21:52:27.527] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:27.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:16:0) after 1m0s
[21:53:27.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:16:0)
[21:53:27.597] Timer tick, asking Buildbucket for the build status
[21:53:27.702] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:27.702] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:17:0) after 1m0s
[21:54:27.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:17:0)
[21:54:27.726] Timer tick, asking Buildbucket for the build status
[21:54:27.817] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:27.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:18:0) after 1m0s
[21:55:27.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:18:0)
[21:55:27.853] Timer tick, asking Buildbucket for the build status
[21:55:28.331] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:28.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:19:0) after 1m0s
[21:56:28.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:19:0)
[21:56:28.371] Timer tick, asking Buildbucket for the build status
[21:56:28.600] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:28.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:20:0) after 1m0s
[21:57:28.613] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:20:0)
[21:57:28.613] Timer tick, asking Buildbucket for the build status
[21:57:28.769] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:28.769] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:21:0) after 1m0s
[21:58:28.842] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:21:0)
[21:58:28.842] Timer tick, asking Buildbucket for the build status
[21:58:28.966] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:28.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:22:0) after 1m0s
[21:59:29.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:22:0)
[21:59:29.077] Timer tick, asking Buildbucket for the build status
[21:59:29.211] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:29.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:23:0) after 1m0s
[22:00:29.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:23:0)
[22:00:29.257] Timer tick, asking Buildbucket for the build status
[22:00:29.913] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:29.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:24:0) after 1m0s
[22:01:30.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:24:0)
[22:01:30.084] Timer tick, asking Buildbucket for the build status
[22:01:30.260] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:30.260] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:25:0) after 1m0s
[22:02:30.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:25:0)
[22:02:30.332] Timer tick, asking Buildbucket for the build status
[22:02:30.924] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:30.924] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:26:0) after 1m0s
[22:03:30.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:26:0)
[22:03:30.943] Timer tick, asking Buildbucket for the build status
[22:03:31.513] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:31.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:27:0) after 1m0s
[22:04:31.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:27:0)
[22:04:31.604] Timer tick, asking Buildbucket for the build status
[22:04:32.713] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:32.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:28:0) after 1m0s
[22:05:32.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:28:0)
[22:05:32.738] Timer tick, asking Buildbucket for the build status
[22:05:33.757] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:33.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:29:0) after 1m0s
[22:06:33.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:29:0)
[22:06:33.853] Timer tick, asking Buildbucket for the build status
[22:06:35.682] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:35.682] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:30:0) after 1m0s
[22:07:35.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:30:0)
[22:07:35.736] Timer tick, asking Buildbucket for the build status
[22:07:36.082] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:36.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:31:0) after 1m0s
[22:08:36.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:31:0)
[22:08:36.143] Timer tick, asking Buildbucket for the build status
[22:08:37.184] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:37.184] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:32:0) after 1m0s
[22:09:37.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:32:0)
[22:09:37.332] Timer tick, asking Buildbucket for the build status
[22:09:37.482] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:37.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:33:0) after 1m0s
[22:10:37.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:33:0)
[22:10:37.586] Timer tick, asking Buildbucket for the build status
[22:10:37.783] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:37.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:34:0) after 1m0s
[22:11:37.764] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:34:0)
[22:11:37.764] Timer tick, asking Buildbucket for the build status
[22:11:40.240] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:40.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:35:0) after 1m0s
[22:12:40.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:35:0)
[22:12:40.295] Timer tick, asking Buildbucket for the build status
[22:12:40.391] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:40.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:36:0) after 1m0s
[22:13:40.480] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:36:0)
[22:13:40.480] Timer tick, asking Buildbucket for the build status
[22:13:40.891] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:40.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:37:0) after 1m0s
[22:14:41.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:37:0)
[22:14:41.027] Timer tick, asking Buildbucket for the build status
[22:14:41.997] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:41.997] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:38:0) after 1m0s
[22:15:42.081] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:38:0)
[22:15:42.081] Timer tick, asking Buildbucket for the build status
[22:15:42.205] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:42.205] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:39:0) after 1m0s
[22:16:42.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:39:0)
[22:16:42.278] Timer tick, asking Buildbucket for the build status
[22:16:42.961] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:42.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:40:0) after 1m0s
[22:17:43.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:40:0)
[22:17:43.028] Timer tick, asking Buildbucket for the build status
[22:17:43.177] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:43.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:41:0) after 1m0s
[22:18:43.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:41:0)
[22:18:43.985] Timer tick, asking Buildbucket for the build status
[22:18:44.463] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:44.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:42:0) after 1m0s
[22:19:44.525] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:42:0)
[22:19:44.525] Timer tick, asking Buildbucket for the build status
[22:19:46.195] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:46.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:43:0) after 1m0s
[22:20:46.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:43:0)
[22:20:46.224] Timer tick, asking Buildbucket for the build status
[22:20:47.940] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:47.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:44:0) after 1m0s
[22:21:47.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:44:0)
[22:21:47.949] Timer tick, asking Buildbucket for the build status
[22:21:48.170] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:48.170] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:45:0) after 1m0s
[22:22:48.315] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:45:0)
[22:22:48.315] Timer tick, asking Buildbucket for the build status
[22:22:48.827] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:48.827] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:46:0) after 1m0s
[22:23:49.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:46:0)
[22:23:49.087] Timer tick, asking Buildbucket for the build status
[22:23:49.821] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:49.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:47:0) after 1m0s
[22:24:49.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:47:0)
[22:24:49.878] Timer tick, asking Buildbucket for the build status
[22:24:50.154] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:50.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:48:0) after 1m0s
[22:25:50.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:48:0)
[22:25:50.254] Timer tick, asking Buildbucket for the build status
[22:25:50.571] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:50.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:49:0) after 1m0s
[22:26:50.636] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:49:0)
[22:26:50.636] Timer tick, asking Buildbucket for the build status
[22:26:50.953] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:50.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:50:0) after 1m0s
[22:27:51.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:50:0)
[22:27:51.045] Timer tick, asking Buildbucket for the build status
[22:27:51.566] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:51.566] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:51:0) after 1m0s
[22:28:51.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:51:0)
[22:28:51.656] Timer tick, asking Buildbucket for the build status
[22:28:53.030] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:53.030] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:52:0) after 1m0s
[22:29:53.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:52:0)
[22:29:53.133] Timer tick, asking Buildbucket for the build status
[22:29:56.127] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:56.127] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:53:0) after 1m0s
[22:30:56.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:53:0)
[22:30:56.296] Timer tick, asking Buildbucket for the build status
[22:30:56.646] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:56.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:54:0) after 1m0s
[22:31:56.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:54:0)
[22:31:56.723] Timer tick, asking Buildbucket for the build status
[22:31:58.220] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:58.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:55:0) after 1m0s
[22:32:58.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:55:0)
[22:32:58.218] Timer tick, asking Buildbucket for the build status
[22:32:59.807] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:59.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:56:0) after 1m0s
[22:33:59.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:56:0)
[22:33:59.901] Timer tick, asking Buildbucket for the build status
[22:34:00.254] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:00.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:57:0) after 1m0s
[22:35:00.424] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:57:0)
[22:35:00.424] Timer tick, asking Buildbucket for the build status
[22:35:01.619] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:01.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:58:0) after 1m0s
[22:36:01.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:58:0)
[22:36:01.664] Timer tick, asking Buildbucket for the build status
[22:36:03.728] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:03.728] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:59:0) after 1m0s
[22:37:03.737] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:59:0)
[22:37:03.737] Timer tick, asking Buildbucket for the build status
[22:37:03.871] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:03.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:60:0) after 1m0s
[22:38:03.945] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:60:0)
[22:38:03.945] Timer tick, asking Buildbucket for the build status
[22:38:04.130] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:04.130] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:61:0) after 1m0s
[22:39:04.225] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:61:0)
[22:39:04.225] Timer tick, asking Buildbucket for the build status
[22:39:04.626] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:04.626] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:62:0) after 1m0s
[22:40:04.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:62:0)
[22:40:04.759] Timer tick, asking Buildbucket for the build status
[22:40:04.945] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:04.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:63:0) after 1m0s
[22:41:05.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:63:0)
[22:41:05.157] Timer tick, asking Buildbucket for the build status
[22:41:06.142] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:06.142] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:64:0) after 1m0s
[22:42:06.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:64:0)
[22:42:06.155] Timer tick, asking Buildbucket for the build status
[22:42:06.713] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:06.713] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:65:0) after 1m0s
[22:43:06.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:65:0)
[22:43:06.887] Timer tick, asking Buildbucket for the build status
[22:43:08.587] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:08.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:66:0) after 1m0s
[22:44:08.870] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:66:0)
[22:44:08.870] Timer tick, asking Buildbucket for the build status
[22:44:11.005] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:11.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:67:0) after 1m0s
[22:45:11.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:67:0)
[22:45:11.031] Timer tick, asking Buildbucket for the build status
[22:45:13.315] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:13.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:68:0) after 1m0s
[22:46:13.360] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:68:0)
[22:46:13.360] Timer tick, asking Buildbucket for the build status
[22:46:14.116] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:14.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:69:0) after 1m0s
[22:47:14.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:69:0)
[22:47:14.179] Timer tick, asking Buildbucket for the build status
[22:47:16.181] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:16.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:70:0) after 1m0s
[22:48:16.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:70:0)
[22:48:16.236] Timer tick, asking Buildbucket for the build status
[22:48:16.812] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:16.812] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:71:0) after 1m0s
[22:49:16.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:71:0)
[22:49:16.885] Timer tick, asking Buildbucket for the build status
[22:49:17.238] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:17.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:72:0) after 1m0s
[22:50:17.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:72:0)
[22:50:17.283] Timer tick, asking Buildbucket for the build status
[22:50:18.005] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:18.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:73:0) after 1m0s
[22:51:18.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:73:0)
[22:51:18.122] Timer tick, asking Buildbucket for the build status
[22:51:19.171] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:19.171] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:74:0) after 1m0s
[22:52:19.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:74:0)
[22:52:19.240] Timer tick, asking Buildbucket for the build status
[22:52:19.464] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:19.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:75:0) after 1m0s
[22:53:19.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:75:0)
[22:53:19.573] Timer tick, asking Buildbucket for the build status
[22:53:21.182] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:21.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:76:0) after 1m0s
[22:54:21.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:76:0)
[22:54:21.242] Timer tick, asking Buildbucket for the build status
[22:54:21.642] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:21.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:77:0) after 1m0s
[22:55:21.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:77:0)
[22:55:21.679] Timer tick, asking Buildbucket for the build status
[22:55:21.928] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:21.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:78:0) after 1m0s
[22:56:21.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:78:0)
[22:56:21.957] Timer tick, asking Buildbucket for the build status
[22:56:22.121] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:22.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:79:0) after 1m0s
[22:57:22.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:79:0)
[22:57:22.185] Timer tick, asking Buildbucket for the build status
[22:57:23.942] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:23.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:80:0) after 1m0s
[22:58:24.000] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:80:0)
[22:58:24.000] Timer tick, asking Buildbucket for the build status
[22:58:27.690] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:27.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:81:0) after 1m0s
[22:59:27.779] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:81:0)
[22:59:27.779] Timer tick, asking Buildbucket for the build status
[22:59:27.923] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:27.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:82:0) after 1m0s
[23:00:27.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:82:0)
[23:00:27.939] Timer tick, asking Buildbucket for the build status
[23:00:28.354] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:28.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:83:0) after 1m0s
[23:01:28.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:83:0)
[23:01:28.379] Timer tick, asking Buildbucket for the build status
[23:01:28.506] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:28.506] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:84:0) after 1m0s
[23:02:28.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:84:0)
[23:02:28.639] Timer tick, asking Buildbucket for the build status
[23:02:28.771] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:28.771] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:85:0) after 1m0s
[23:03:28.812] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:85:0)
[23:03:28.812] Timer tick, asking Buildbucket for the build status
[23:03:29.714] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:29.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:86:0) after 1m0s
[23:04:29.779] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:86:0)
[23:04:29.779] Timer tick, asking Buildbucket for the build status
[23:04:32.117] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:32.117] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:87:0) after 1m0s
[23:05:32.140] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:87:0)
[23:05:32.140] Timer tick, asking Buildbucket for the build status
[23:05:34.170] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:34.170] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:88:0) after 1m0s
[23:06:34.253] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:88:0)
[23:06:34.253] Timer tick, asking Buildbucket for the build status
[23:06:34.332] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:34.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:89:0) after 1m0s
[23:07:34.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:89:0)
[23:07:34.442] Timer tick, asking Buildbucket for the build status
[23:07:34.853] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:34.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:90:0) after 1m0s
[23:08:34.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:90:0)
[23:08:34.962] Timer tick, asking Buildbucket for the build status
[23:08:35.138] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:35.138] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:91:0) after 1m0s
[23:09:35.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:91:0)
[23:09:35.233] Timer tick, asking Buildbucket for the build status
[23:09:37.552] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:37.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:92:0) after 1m0s
[23:10:37.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:92:0)
[23:10:37.648] Timer tick, asking Buildbucket for the build status
[23:10:38.569] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:38.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:93:0) after 1m0s
[23:11:38.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:93:0)
[23:11:38.603] Timer tick, asking Buildbucket for the build status
[23:11:41.858] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:41.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:94:0) after 1m0s
[23:12:41.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:94:0)
[23:12:41.992] Timer tick, asking Buildbucket for the build status
[23:12:42.129] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:42.129] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:95:0) after 1m0s
[23:13:42.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:95:0)
[23:13:42.200] Timer tick, asking Buildbucket for the build status
[23:13:42.697] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:42.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:96:0) after 1m0s
[23:14:42.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:96:0)
[23:14:42.699] Timer tick, asking Buildbucket for the build status
[23:14:42.833] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:42.833] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:97:0) after 1m0s
[23:15:42.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:97:0)
[23:15:42.907] Timer tick, asking Buildbucket for the build status
[23:15:45.285] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:45.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:98:0) after 1m0s
[23:16:45.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:98:0)
[23:16:45.388] Timer tick, asking Buildbucket for the build status
[23:16:47.250] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:47.250] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:99:0) after 1m0s
[23:17:47.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:99:0)
[23:17:47.340] Timer tick, asking Buildbucket for the build status
[23:17:48.970] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:48.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:100:0) after 1m0s
[23:18:48.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:100:0)
[23:18:48.995] Timer tick, asking Buildbucket for the build status
[23:18:49.196] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:49.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:101:0) after 1m0s
[23:19:49.225] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:101:0)
[23:19:49.225] Timer tick, asking Buildbucket for the build status
[23:19:49.472] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:49.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:102:0) after 1m0s
[23:20:49.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:102:0)
[23:20:49.504] Timer tick, asking Buildbucket for the build status
[23:20:49.954] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:49.954] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:103:0) after 1m0s
[23:21:50.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:103:0)
[23:21:50.075] Timer tick, asking Buildbucket for the build status
[23:21:50.341] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:50.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:104:0) after 1m0s
[23:22:50.403] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:104:0)
[23:22:50.403] Timer tick, asking Buildbucket for the build status
[23:22:50.920] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:50.920] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:105:0) after 1m0s
[23:23:50.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:105:0)
[23:23:50.915] Timer tick, asking Buildbucket for the build status
[23:23:52.484] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:52.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:106:0) after 1m0s
[23:24:52.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:106:0)
[23:24:52.515] Timer tick, asking Buildbucket for the build status
[23:24:54.518] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:54.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:107:0) after 1m0s
[23:25:54.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:107:0)
[23:25:54.546] Timer tick, asking Buildbucket for the build status
[23:25:55.701] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:55.701] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:108:0) after 1m0s
[23:26:55.795] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:108:0)
[23:26:55.795] Timer tick, asking Buildbucket for the build status
[23:26:55.951] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:55.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:109:0) after 1m0s
[23:27:56.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:109:0)
[23:27:56.029] Timer tick, asking Buildbucket for the build status
[23:27:56.313] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:56.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:110:0) after 1m0s
[23:28:56.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:110:0)
[23:28:56.334] Timer tick, asking Buildbucket for the build status
[23:28:56.622] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:56.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:111:0) after 1m0s
[23:29:56.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:111:0)
[23:29:56.616] Timer tick, asking Buildbucket for the build status
[23:29:57.368] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:57.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:112:0) after 1m0s
[23:30:57.376] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:112:0)
[23:30:57.376] Timer tick, asking Buildbucket for the build status
[23:30:57.695] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:57.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:113:0) after 1m0s
[23:31:58.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:113:0)
[23:31:58.409] Timer tick, asking Buildbucket for the build status
[23:31:59.473] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:59.473] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:114:0) after 1m0s
[23:32:59.560] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:114:0)
[23:32:59.560] Timer tick, asking Buildbucket for the build status
[23:33:01.140] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:01.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:115:0) after 1m0s
[23:34:01.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:115:0)
[23:34:01.229] Timer tick, asking Buildbucket for the build status
[23:34:02.451] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:02.451] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:116:0) after 1m0s
[23:35:02.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:116:0)
[23:35:02.544] Timer tick, asking Buildbucket for the build status
[23:35:02.697] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:02.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:117:0) after 1m0s
[23:36:02.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:117:0)
[23:36:02.729] Timer tick, asking Buildbucket for the build status
[23:36:03.318] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:03.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:118:0) after 1m0s
[23:37:03.361] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:118:0)
[23:37:03.361] Timer tick, asking Buildbucket for the build status
[23:37:03.796] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:03.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:119:0) after 1m0s
[23:38:03.961] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:119:0)
[23:38:03.961] Timer tick, asking Buildbucket for the build status
[23:38:04.968] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:04.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:120:0) after 1m0s
[23:39:05.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:120:0)
[23:39:05.094] Timer tick, asking Buildbucket for the build status
[23:39:05.826] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:05.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:121:0) after 1m0s
[23:40:05.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:121:0)
[23:40:05.829] Timer tick, asking Buildbucket for the build status
[23:40:07.854] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:07.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:122:0) after 1m0s
[23:41:07.912] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:122:0)
[23:41:07.912] Timer tick, asking Buildbucket for the build status
[23:41:08.095] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:08.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:123:0) after 1m0s
[23:42:08.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:123:0)
[23:42:08.179] Timer tick, asking Buildbucket for the build status
[23:42:09.596] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:09.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:124:0) after 1m0s
[23:43:09.593] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:124:0)
[23:43:09.593] Timer tick, asking Buildbucket for the build status
[23:43:10.092] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:10.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:125:0) after 1m0s
[23:44:10.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:125:0)
[23:44:10.126] Timer tick, asking Buildbucket for the build status
[23:44:11.699] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:11.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:126:0) after 1m0s
[23:45:11.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:126:0)
[23:45:11.833] Timer tick, asking Buildbucket for the build status
[23:45:13.164] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:13.165] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:127:0) after 1m0s
[23:46:13.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:127:0)
[23:46:13.176] Timer tick, asking Buildbucket for the build status
[23:46:13.840] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:13.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:128:0) after 1m0s
[23:47:13.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:128:0)
[23:47:13.979] Timer tick, asking Buildbucket for the build status
[23:47:15.602] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:15.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:129:0) after 1m0s
[23:48:15.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:129:0)
[23:48:15.666] Timer tick, asking Buildbucket for the build status
[23:48:16.284] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:16.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:130:0) after 1m0s
[23:49:16.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:130:0)
[23:49:16.331] Timer tick, asking Buildbucket for the build status
[23:49:17.263] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:17.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:131:0) after 1m0s
[23:50:17.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:131:0)
[23:50:17.285] Timer tick, asking Buildbucket for the build status
[23:50:18.463] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:18.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:132:0) after 1m0s
[23:51:18.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:132:0)
[23:51:18.582] Timer tick, asking Buildbucket for the build status
[23:51:18.871] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:18.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:133:0) after 1m0s
[23:52:19.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:133:0)
[23:52:19.018] Timer tick, asking Buildbucket for the build status
[23:52:19.156] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:19.157] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:134:0) after 1m0s
[23:53:19.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:134:0)
[23:53:19.230] Timer tick, asking Buildbucket for the build status
[23:53:20.435] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:20.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:135:0) after 1m0s
[23:54:20.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:135:0)
[23:54:20.513] Timer tick, asking Buildbucket for the build status
[23:54:22.582] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:22.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:136:0) after 1m0s
[23:55:22.670] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:136:0)
[23:55:22.670] Timer tick, asking Buildbucket for the build status
[23:55:25.112] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:25.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:137:0) after 1m0s
[23:56:25.215] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:137:0)
[23:56:25.215] Timer tick, asking Buildbucket for the build status
[23:56:26.023] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:26.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:138:0) after 1m0s
[23:57:26.080] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:138:0)
[23:57:26.080] Timer tick, asking Buildbucket for the build status
[23:57:27.308] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:27.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:139:0) after 1m0s
[23:58:27.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:139:0)
[23:58:27.336] Timer tick, asking Buildbucket for the build status
[23:58:29.852] Build 8911636724837554608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:29.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077066787457275792:140:0) after 1m0s
[23:58:48.673] Received PubSub notification, asking Buildbucket for the build status
[23:58:48.831] Build 8911636724837554608: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:58:48.831] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559606328092066",
"created_by": "project:chromium",
"created_ts": "1559597960587706",
"experimental": true,
"failure_reason": "BUILD_FAILURE",
"id": "8911636724837554608",
"parameters_json": "{\"builder_name\": \"Deterministic Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"178575e5c2a0fcaf566d5e39a60b65847b59d2ee\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"properties\": {\"$build/goma\": {\"jobs\": 150.0}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"bot_id\": \"deterministic-android-rel-0-y0is\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Android\", \"buildnumber\": 5340, \"got_angle_revision\": \"4a75741655d330e257b2f20d7404cce1e51ef72e\", \"got_dawn_revision\": \"c2750abd0c62608f0ebed44aae3716257e8dec41\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"178575e5c2a0fcaf566d5e39a60b65847b59d2ee\", \"got_revision_cp\": \"refs/heads/master@{#665664}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"d6158eea40c4b8863977f863a26aeb8f423b17b8\", \"got_v8_revision_cp\": \"refs/heads/7.7.6@{#1}\", \"got_webrtc_revision\": \"e86af2c75fe6ac8bfc0b1ee31b1bdf10da14fe52\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28142}\", \"mastername\": \"chromium.android\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"178575e5c2a0fcaf566d5e39a60b65847b59d2ee\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Deterministic Android\"], \"caches\": [\"builder_0442f466ee54a95cfb510061921bb277cbb8d5a6f79e09e045baf9198c2b257e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"deterministic-android-rel-0-y0is\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"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\": [\"4316-effbcfc\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"Step('compare_build_artifacts') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559598004287976",
"status": "COMPLETED",
"status_changed_ts": "1559598004591132",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android/5340",
"builder:Deterministic Android",
"buildset:commit/git/178575e5c2a0fcaf566d5e39a60b65847b59d2ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/178575e5c2a0fcaf566d5e39a60b65847b59d2ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077066787457275792",
"scheduler_job_id:chromium/Deterministic Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8911636724837554608/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:453819da9c30d210",
"user_agent:luci-scheduler"
],
"updated_ts": "1559606328397082",
"url": "https://ci.chromium.org/b/8911636724837554608",
"utcnow_ts": "1559606328807667"
}
}
[23:58:48.831] Invocation finished in 2h19m30.126058109s with status FAILED