[21:36:13.821] New invocation is queued and will start shortly
[21:36:15.357] Starting the invocation (attempt 1)
[21:36:15.439] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:36:15.439] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:36:15.440] Buildbucket request:
{
"bucket": "luci.nacl.toolchain",
"client_operation_id": "9087485632475785712",
"parameters_json": "{\"builder_name\":\"linux-pnacl-x86_32-tests-mips\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"9f733c9d96b89a0889aea72fb1003f78fa4017cb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-pnacl-x86_32-tests-mips",
"scheduler_invocation_id:9087485632475785712",
"scheduler_job_id:nacl/linux-pnacl-x86_32-tests-mips",
"user_agent:luci-scheduler",
"buildset:commit/git/9f733c9d96b89a0889aea72fb1003f78fa4017cb",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f733c9d96b89a0889aea72fb1003f78fa4017cb",
"gitiles_ref:refs/heads/master"
]
}
[21:36:17.067] Buildbucket response:
{
"build": {
"bucket": "luci.nacl.toolchain",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1549661775556822",
"id": "8922055569992767392",
"lease_expiration_ts": "1549780576431539",
"lease_key": "1710344373",
"parameters_json": "{\"builder_name\": \"linux-pnacl-x86_32-tests-mips\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f733c9d96b89a0889aea72fb1003f78fa4017cb\"}}",
"project": "nacl",
"result_details_json": "{\"properties\": {}}",
"service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1549661776861891",
"tags": [
"build_address:luci.nacl.toolchain/linux-pnacl-x86_32-tests-mips/4958",
"builder:linux-pnacl-x86_32-tests-mips",
"buildset:commit/git/9f733c9d96b89a0889aea72fb1003f78fa4017cb",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f733c9d96b89a0889aea72fb1003f78fa4017cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9087485632475785712",
"scheduler_job_id:nacl/linux-pnacl-x86_32-tests-mips",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8922055569992767392/+/annotations",
"swarming_tag:luci_project:nacl",
"swarming_tag:recipe_name:nacl",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:42e7dbb118298110",
"user_agent:luci-scheduler"
],
"updated_ts": "1549661776862040",
"url": "https://ci.chromium.org/b/8922055569992767392",
"utcnow_ts": "1549661777055180"
}
}
[21:36:17.067] Task URL: https://ci.chromium.org/b/8922055569992767392
[21:36:17.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:2:0) after 1m0s
[21:37:17.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:2:0)
[21:37:17.168] Timer tick, asking Buildbucket for the build status
[21:37:17.276] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:37:17.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:3:0) after 1m0s
[21:38:17.356] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:3:0)
[21:38:17.356] Timer tick, asking Buildbucket for the build status
[21:38:17.413] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:38:17.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:4:0) after 1m0s
[21:39:17.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:4:0)
[21:39:17.459] Timer tick, asking Buildbucket for the build status
[21:39:17.510] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:39:17.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:5:0) after 1m0s
[21:40:17.558] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:5:0)
[21:40:17.558] Timer tick, asking Buildbucket for the build status
[21:40:17.610] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:40:17.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:6:0) after 1m0s
[21:41:17.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:6:0)
[21:41:17.656] Timer tick, asking Buildbucket for the build status
[21:41:17.725] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:41:17.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:7:0) after 1m0s
[21:42:17.850] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:7:0)
[21:42:17.850] Timer tick, asking Buildbucket for the build status
[21:42:17.932] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:42:17.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:8:0) after 1m0s
[21:43:18.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:8:0)
[21:43:18.046] Timer tick, asking Buildbucket for the build status
[21:43:18.117] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:43:18.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:9:0) after 1m0s
[21:44:18.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:9:0)
[21:44:18.135] Timer tick, asking Buildbucket for the build status
[21:44:18.202] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:44:18.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:10:0) after 1m0s
[21:45:18.246] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:10:0)
[21:45:18.246] Timer tick, asking Buildbucket for the build status
[21:45:18.295] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:18.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:11:0) after 1m0s
[21:46:18.855] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:11:0)
[21:46:18.855] Timer tick, asking Buildbucket for the build status
[21:46:18.987] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:18.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:12:0) after 1m0s
[21:47:19.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:12:0)
[21:47:19.006] Timer tick, asking Buildbucket for the build status
[21:47:19.202] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:47:19.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:13:0) after 1m0s
[21:48:19.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:13:0)
[21:48:19.233] Timer tick, asking Buildbucket for the build status
[21:48:19.323] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:48:19.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:14:0) after 1m0s
[21:49:19.342] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:14:0)
[21:49:19.342] Timer tick, asking Buildbucket for the build status
[21:49:19.402] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:19.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:15:0) after 1m0s
[21:50:19.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:15:0)
[21:50:19.424] Timer tick, asking Buildbucket for the build status
[21:50:19.522] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:50:19.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:16:0) after 1m0s
[21:51:19.538] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:16:0)
[21:51:19.539] Timer tick, asking Buildbucket for the build status
[21:51:19.592] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:51:19.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:17:0) after 1m0s
[21:52:19.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:17:0)
[21:52:19.616] Timer tick, asking Buildbucket for the build status
[21:52:19.688] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:52:19.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:18:0) after 1m0s
[21:53:19.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:18:0)
[21:53:19.706] Timer tick, asking Buildbucket for the build status
[21:53:19.821] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:53:19.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:19:0) after 1m0s
[21:54:19.837] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:19:0)
[21:54:19.837] Timer tick, asking Buildbucket for the build status
[21:54:19.906] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:54:19.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:20:0) after 1m0s
[21:55:19.931] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:20:0)
[21:55:19.931] Timer tick, asking Buildbucket for the build status
[21:55:20.012] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:55:20.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:21:0) after 1m0s
[21:56:20.067] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:21:0)
[21:56:20.067] Timer tick, asking Buildbucket for the build status
[21:56:20.294] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:56:20.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:22:0) after 1m0s
[21:57:20.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:22:0)
[21:57:20.312] Timer tick, asking Buildbucket for the build status
[21:57:20.472] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:57:20.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:23:0) after 1m0s
[21:58:20.546] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:23:0)
[21:58:20.546] Timer tick, asking Buildbucket for the build status
[21:58:20.607] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:58:20.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:24:0) after 1m0s
[21:59:20.651] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:24:0)
[21:59:20.651] Timer tick, asking Buildbucket for the build status
[21:59:20.705] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:20.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:25:0) after 1m0s
[22:00:20.770] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:25:0)
[22:00:20.770] Timer tick, asking Buildbucket for the build status
[22:00:20.844] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:20.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:26:0) after 1m0s
[22:01:20.863] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:26:0)
[22:01:20.863] Timer tick, asking Buildbucket for the build status
[22:01:20.989] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:20.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:27:0) after 1m0s
[22:02:21.007] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:27:0)
[22:02:21.007] Timer tick, asking Buildbucket for the build status
[22:02:21.067] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:21.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:28:0) after 1m0s
[22:03:21.102] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:28:0)
[22:03:21.102] Timer tick, asking Buildbucket for the build status
[22:03:21.189] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:21.189] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:29:0) after 1m0s
[22:04:21.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:29:0)
[22:04:21.207] Timer tick, asking Buildbucket for the build status
[22:04:21.310] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:21.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:30:0) after 1m0s
[22:05:21.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:30:0)
[22:05:21.333] Timer tick, asking Buildbucket for the build status
[22:05:21.469] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:21.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:31:0) after 1m0s
[22:06:21.488] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:31:0)
[22:06:21.488] Timer tick, asking Buildbucket for the build status
[22:06:21.540] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:21.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:32:0) after 1m0s
[22:07:21.605] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:32:0)
[22:07:21.605] Timer tick, asking Buildbucket for the build status
[22:07:21.654] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:21.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:33:0) after 1m0s
[22:08:21.670] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:33:0)
[22:08:21.670] Timer tick, asking Buildbucket for the build status
[22:08:21.731] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:21.731] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:34:0) after 1m0s
[22:09:21.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:34:0)
[22:09:21.755] Timer tick, asking Buildbucket for the build status
[22:09:21.826] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:21.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:35:0) after 1m0s
[22:10:21.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:35:0)
[22:10:21.856] Timer tick, asking Buildbucket for the build status
[22:10:21.927] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:21.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:36:0) after 1m0s
[22:11:21.946] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:36:0)
[22:11:21.946] Timer tick, asking Buildbucket for the build status
[22:11:22.002] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:11:22.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:37:0) after 1m0s
[22:12:22.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:37:0)
[22:12:22.025] Timer tick, asking Buildbucket for the build status
[22:12:22.097] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:12:22.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:38:0) after 1m0s
[22:13:22.114] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:38:0)
[22:13:22.114] Timer tick, asking Buildbucket for the build status
[22:13:22.257] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:13:22.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:39:0) after 1m0s
[22:14:22.274] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:39:0)
[22:14:22.274] Timer tick, asking Buildbucket for the build status
[22:14:22.402] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:14:22.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:40:0) after 1m0s
[22:15:22.423] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:40:0)
[22:15:22.423] Timer tick, asking Buildbucket for the build status
[22:15:22.497] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:15:22.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:41:0) after 1m0s
[22:16:22.513] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:41:0)
[22:16:22.513] Timer tick, asking Buildbucket for the build status
[22:16:22.664] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:16:22.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:42:0) after 1m0s
[22:17:22.683] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:42:0)
[22:17:22.683] Timer tick, asking Buildbucket for the build status
[22:17:22.796] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:17:22.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:43:0) after 1m0s
[22:18:22.820] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:43:0)
[22:18:22.820] Timer tick, asking Buildbucket for the build status
[22:18:22.967] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:18:22.967] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:44:0) after 1m0s
[22:19:23.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:44:0)
[22:19:23.046] Timer tick, asking Buildbucket for the build status
[22:19:23.099] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:19:23.099] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:45:0) after 1m0s
[22:20:23.160] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:45:0)
[22:20:23.160] Timer tick, asking Buildbucket for the build status
[22:20:23.279] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:23.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:46:0) after 1m0s
[22:21:23.299] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:46:0)
[22:21:23.299] Timer tick, asking Buildbucket for the build status
[22:21:23.348] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:23.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:47:0) after 1m0s
[22:22:23.370] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:47:0)
[22:22:23.370] Timer tick, asking Buildbucket for the build status
[22:22:23.442] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:23.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:48:0) after 1m0s
[22:23:23.460] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:48:0)
[22:23:23.460] Timer tick, asking Buildbucket for the build status
[22:23:23.513] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:23.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:49:0) after 1m0s
[22:24:23.531] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:49:0)
[22:24:23.531] Timer tick, asking Buildbucket for the build status
[22:24:23.613] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:23.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:50:0) after 1m0s
[22:25:23.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:50:0)
[22:25:23.658] Timer tick, asking Buildbucket for the build status
[22:25:23.725] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:23.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:51:0) after 1m0s
[22:26:23.779] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:51:0)
[22:26:23.779] Timer tick, asking Buildbucket for the build status
[22:26:23.834] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:23.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:52:0) after 1m0s
[22:27:23.864] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:52:0)
[22:27:23.864] Timer tick, asking Buildbucket for the build status
[22:27:23.929] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:23.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:53:0) after 1m0s
[22:28:23.960] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:53:0)
[22:28:23.960] Timer tick, asking Buildbucket for the build status
[22:28:24.078] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:24.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:54:0) after 1m0s
[22:29:24.099] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:54:0)
[22:29:24.099] Timer tick, asking Buildbucket for the build status
[22:29:24.222] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:24.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:55:0) after 1m0s
[22:30:24.248] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:55:0)
[22:30:24.248] Timer tick, asking Buildbucket for the build status
[22:30:24.393] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:24.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:56:0) after 1m0s
[22:31:24.412] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:56:0)
[22:31:24.412] Timer tick, asking Buildbucket for the build status
[22:31:24.463] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:24.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:57:0) after 1m0s
[22:32:24.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:57:0)
[22:32:24.485] Timer tick, asking Buildbucket for the build status
[22:32:24.564] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:24.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:58:0) after 1m0s
[22:33:24.661] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:58:0)
[22:33:24.661] Timer tick, asking Buildbucket for the build status
[22:33:24.808] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:24.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:59:0) after 1m0s
[22:34:24.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:59:0)
[22:34:24.829] Timer tick, asking Buildbucket for the build status
[22:34:24.901] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:24.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:60:0) after 1m0s
[22:35:24.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:60:0)
[22:35:24.921] Timer tick, asking Buildbucket for the build status
[22:35:25.154] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:25.154] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:61:0) after 1m0s
[22:36:25.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:61:0)
[22:36:25.177] Timer tick, asking Buildbucket for the build status
[22:36:25.268] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:25.268] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:62:0) after 1m0s
[22:37:25.293] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:62:0)
[22:37:25.293] Timer tick, asking Buildbucket for the build status
[22:37:25.352] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:25.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:63:0) after 1m0s
[22:38:25.370] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:63:0)
[22:38:25.370] Timer tick, asking Buildbucket for the build status
[22:38:25.438] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:25.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:64:0) after 1m0s
[22:39:25.458] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:64:0)
[22:39:25.458] Timer tick, asking Buildbucket for the build status
[22:39:25.517] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:25.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:65:0) after 1m0s
[22:40:25.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:65:0)
[22:40:25.536] Timer tick, asking Buildbucket for the build status
[22:40:25.604] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:25.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:66:0) after 1m0s
[22:41:25.624] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:66:0)
[22:41:25.624] Timer tick, asking Buildbucket for the build status
[22:41:25.691] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:25.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:67:0) after 1m0s
[22:42:25.711] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:67:0)
[22:42:25.711] Timer tick, asking Buildbucket for the build status
[22:42:25.806] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:25.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:68:0) after 1m0s
[22:43:25.837] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:68:0)
[22:43:25.837] Timer tick, asking Buildbucket for the build status
[22:43:26.012] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:26.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:69:0) after 1m0s
[22:44:26.038] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:69:0)
[22:44:26.038] Timer tick, asking Buildbucket for the build status
[22:44:26.107] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:26.107] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:70:0) after 1m0s
[22:45:26.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:70:0)
[22:45:26.127] Timer tick, asking Buildbucket for the build status
[22:45:26.217] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:26.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:71:0) after 1m0s
[22:46:26.252] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:71:0)
[22:46:26.252] Timer tick, asking Buildbucket for the build status
[22:46:26.334] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:26.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:72:0) after 1m0s
[22:47:26.356] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:72:0)
[22:47:26.356] Timer tick, asking Buildbucket for the build status
[22:47:26.427] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:26.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:73:0) after 1m0s
[22:48:26.445] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:73:0)
[22:48:26.445] Timer tick, asking Buildbucket for the build status
[22:48:26.508] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:26.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:74:0) after 1m0s
[22:49:26.567] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:74:0)
[22:49:26.567] Timer tick, asking Buildbucket for the build status
[22:49:26.674] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:26.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:75:0) after 1m0s
[22:50:26.704] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:75:0)
[22:50:26.704] Timer tick, asking Buildbucket for the build status
[22:50:26.801] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:26.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:76:0) after 1m0s
[22:51:26.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:76:0)
[22:51:26.823] Timer tick, asking Buildbucket for the build status
[22:51:26.894] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:26.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:77:0) after 1m0s
[22:52:26.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:77:0)
[22:52:26.915] Timer tick, asking Buildbucket for the build status
[22:52:27.100] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:27.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:78:0) after 1m0s
[22:53:27.121] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:78:0)
[22:53:27.121] Timer tick, asking Buildbucket for the build status
[22:53:27.214] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:27.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:79:0) after 1m0s
[22:54:27.232] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:79:0)
[22:54:27.232] Timer tick, asking Buildbucket for the build status
[22:54:27.297] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:27.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:80:0) after 1m0s
[22:55:27.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:80:0)
[22:55:27.321] Timer tick, asking Buildbucket for the build status
[22:55:27.400] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:27.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:81:0) after 1m0s
[22:56:27.477] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:81:0)
[22:56:27.478] Timer tick, asking Buildbucket for the build status
[22:56:27.688] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:27.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:82:0) after 1m0s
[22:57:27.714] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:82:0)
[22:57:27.714] Timer tick, asking Buildbucket for the build status
[22:57:27.779] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:27.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:83:0) after 1m0s
[22:58:27.798] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:83:0)
[22:58:27.798] Timer tick, asking Buildbucket for the build status
[22:58:28.022] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:28.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:84:0) after 1m0s
[22:59:28.113] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:84:0)
[22:59:28.113] Timer tick, asking Buildbucket for the build status
[22:59:28.209] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:28.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:85:0) after 1m0s
[23:00:28.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:85:0)
[23:00:28.225] Timer tick, asking Buildbucket for the build status
[23:00:28.370] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:28.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:86:0) after 1m0s
[23:01:28.395] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:86:0)
[23:01:28.395] Timer tick, asking Buildbucket for the build status
[23:01:28.463] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:28.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:87:0) after 1m0s
[23:02:28.507] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:87:0)
[23:02:28.507] Timer tick, asking Buildbucket for the build status
[23:02:28.711] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:28.711] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:88:0) after 1m0s
[23:03:28.731] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:88:0)
[23:03:28.731] Timer tick, asking Buildbucket for the build status
[23:03:29.155] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:29.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:89:0) after 1m0s
[23:04:29.176] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:89:0)
[23:04:29.176] Timer tick, asking Buildbucket for the build status
[23:04:29.241] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:29.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:90:0) after 1m0s
[23:05:29.264] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:90:0)
[23:05:29.264] Timer tick, asking Buildbucket for the build status
[23:05:29.388] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:29.388] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:91:0) after 1m0s
[23:06:29.410] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:91:0)
[23:06:29.410] Timer tick, asking Buildbucket for the build status
[23:06:29.617] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:29.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:92:0) after 1m0s
[23:07:29.635] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:92:0)
[23:07:29.635] Timer tick, asking Buildbucket for the build status
[23:07:29.702] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:29.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:93:0) after 1m0s
[23:08:29.727] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:93:0)
[23:08:29.727] Timer tick, asking Buildbucket for the build status
[23:08:29.831] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:29.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:94:0) after 1m0s
[23:09:29.863] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:94:0)
[23:09:29.864] Timer tick, asking Buildbucket for the build status
[23:09:29.919] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:29.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:95:0) after 1m0s
[23:10:29.939] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:95:0)
[23:10:29.939] Timer tick, asking Buildbucket for the build status
[23:10:30.044] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:30.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:96:0) after 1m0s
[23:11:30.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:96:0)
[23:11:30.067] Timer tick, asking Buildbucket for the build status
[23:11:30.150] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:30.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:97:0) after 1m0s
[23:12:30.200] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:97:0)
[23:12:30.200] Timer tick, asking Buildbucket for the build status
[23:12:30.276] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:30.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:98:0) after 1m0s
[23:13:30.305] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:98:0)
[23:13:30.305] Timer tick, asking Buildbucket for the build status
[23:13:30.373] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:30.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:99:0) after 1m0s
[23:14:30.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:99:0)
[23:14:30.396] Timer tick, asking Buildbucket for the build status
[23:14:30.464] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:30.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:100:0) after 1m0s
[23:15:30.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:100:0)
[23:15:30.503] Timer tick, asking Buildbucket for the build status
[23:15:30.584] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:30.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:101:0) after 1m0s
[23:16:30.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:101:0)
[23:16:30.701] Timer tick, asking Buildbucket for the build status
[23:16:30.879] Build 8922055569992767392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:30.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:102:0) after 1m0s
[23:16:54.756] Received PubSub notification, asking Buildbucket for the build status
[23:16:54.809] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:30.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:102:0)
[23:17:30.899] Timer tick, asking Buildbucket for the build status
[23:17:31.012] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:31.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:104:0) after 1m0s
[23:18:31.040] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:104:0)
[23:18:31.040] Timer tick, asking Buildbucket for the build status
[23:18:31.167] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:31.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:105:0) after 1m0s
[23:19:31.186] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:105:0)
[23:19:31.186] Timer tick, asking Buildbucket for the build status
[23:19:31.312] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:31.312] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:106:0) after 1m0s
[23:20:31.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:106:0)
[23:20:31.333] Timer tick, asking Buildbucket for the build status
[23:20:31.425] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:31.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:107:0) after 1m0s
[23:21:31.442] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:107:0)
[23:21:31.442] Timer tick, asking Buildbucket for the build status
[23:21:31.521] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:31.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:108:0) after 1m0s
[23:22:31.561] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:108:0)
[23:22:31.561] Timer tick, asking Buildbucket for the build status
[23:22:31.618] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:31.618] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:109:0) after 1m0s
[23:23:31.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:109:0)
[23:23:31.646] Timer tick, asking Buildbucket for the build status
[23:23:31.715] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:31.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:110:0) after 1m0s
[23:24:31.734] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:110:0)
[23:24:31.734] Timer tick, asking Buildbucket for the build status
[23:24:31.807] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:31.807] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:111:0) after 1m0s
[23:25:31.834] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:111:0)
[23:25:31.834] Timer tick, asking Buildbucket for the build status
[23:25:31.891] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:31.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:112:0) after 1m0s
[23:26:31.960] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:112:0)
[23:26:31.960] Timer tick, asking Buildbucket for the build status
[23:26:32.025] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:32.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:113:0) after 1m0s
[23:27:32.063] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:113:0)
[23:27:32.064] Timer tick, asking Buildbucket for the build status
[23:27:32.127] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:32.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:114:0) after 1m0s
[23:28:32.152] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:114:0)
[23:28:32.152] Timer tick, asking Buildbucket for the build status
[23:28:32.217] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:32.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:115:0) after 1m0s
[23:29:32.240] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:115:0)
[23:29:32.240] Timer tick, asking Buildbucket for the build status
[23:29:32.291] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:32.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:116:0) after 1m0s
[23:30:32.347] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:116:0)
[23:30:32.347] Timer tick, asking Buildbucket for the build status
[23:30:32.435] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:32.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:117:0) after 1m0s
[23:31:32.456] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:117:0)
[23:31:32.456] Timer tick, asking Buildbucket for the build status
[23:31:32.607] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:32.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:118:0) after 1m0s
[23:32:32.626] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:118:0)
[23:32:32.626] Timer tick, asking Buildbucket for the build status
[23:32:32.755] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:32.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:119:0) after 1m0s
[23:33:32.784] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:119:0)
[23:33:32.784] Timer tick, asking Buildbucket for the build status
[23:33:32.858] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:32.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:120:0) after 1m0s
[23:34:32.881] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:120:0)
[23:34:32.881] Timer tick, asking Buildbucket for the build status
[23:34:32.986] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:32.986] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:121:0) after 1m0s
[23:35:33.009] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:121:0)
[23:35:33.009] Timer tick, asking Buildbucket for the build status
[23:35:33.167] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:33.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:122:0) after 1m0s
[23:36:33.190] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:122:0)
[23:36:33.190] Timer tick, asking Buildbucket for the build status
[23:36:33.267] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:33.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:123:0) after 1m0s
[23:37:33.403] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:123:0)
[23:37:33.403] Timer tick, asking Buildbucket for the build status
[23:37:33.661] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:33.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:124:0) after 1m0s
[23:38:33.695] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:124:0)
[23:38:33.695] Timer tick, asking Buildbucket for the build status
[23:38:33.750] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:33.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:125:0) after 1m0s
[23:39:33.794] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:125:0)
[23:39:33.794] Timer tick, asking Buildbucket for the build status
[23:39:33.863] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:33.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:126:0) after 1m0s
[23:40:33.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:126:0)
[23:40:33.886] Timer tick, asking Buildbucket for the build status
[23:40:34.214] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:34.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:127:0) after 1m0s
[23:41:34.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:127:0)
[23:41:34.233] Timer tick, asking Buildbucket for the build status
[23:41:34.889] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:34.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:128:0) after 1m0s
[23:42:34.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:128:0)
[23:42:34.915] Timer tick, asking Buildbucket for the build status
[23:42:35.062] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:35.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:129:0) after 1m0s
[23:43:35.087] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:129:0)
[23:43:35.087] Timer tick, asking Buildbucket for the build status
[23:43:35.312] Build 8922055569992767392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:35.312] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_32-tests-mips:9087485632475785712:130:0) after 1m0s
[23:43:46.543] Received PubSub notification, asking Buildbucket for the build status
[23:43:46.588] Build 8922055569992767392: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:43:46.588] Buildbucket build:
{
"build": {
"bucket": "luci.nacl.toolchain",
"canary_preference": "AUTO",
"completed_ts": "1549669425790013",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1549661775556822",
"id": "8922055569992767392",
"parameters_json": "{\"builder_name\": \"linux-pnacl-x86_32-tests-mips\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f733c9d96b89a0889aea72fb1003f78fa4017cb\"}}",
"project": "nacl",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"4077-0a4fdfc\"], \"machine_type\": [\"n1-standard-16\"], \"gpu\": [\"none\"], \"cores\": [\"16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-16-145e5bab-us-west1-c-141h\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 4958, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"linux-pnacl-x86_32-tests-mips\", \"key\": \"builder\"}, {\"value\": \"commit/git/9f733c9d96b89a0889aea72fb1003f78fa4017cb\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f733c9d96b89a0889aea72fb1003f78fa4017cb\", \"key\": \"buildset\"}, {\"value\": \"9087485632475785712\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"nacl/linux-pnacl-x86_32-tests-mips\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"nacl\", \"builder\": \"linux-pnacl-x86_32-tests-mips\", \"bucket\": \"toolchain\"}, \"number\": 4958, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"ef156230f5cd7f8c23f689fa4dc7f92742cd904d\"}, \"recipe\": {\"name\": \"nacl\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8922055569992767392\", \"input\": {\"gitilesCommit\": {\"project\": \"native_client/src/native_client\", \"host\": \"chromium.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"9f733c9d96b89a0889aea72fb1003f78fa4017cb\"}}, \"createTime\": \"2019-02-08T21:36:15.556822Z\"}}, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux-pnacl-x86_32-tests-mips\", \"got_revision\": \"9f733c9d96b89a0889aea72fb1003f78fa4017cb\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl.toolchain\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1549661775556822, \"tags\": [\"build_address:luci.nacl.toolchain/linux-pnacl-x86_32-tests-mips/4958\", \"builder:linux-pnacl-x86_32-tests-mips\", \"buildset:commit/git/9f733c9d96b89a0889aea72fb1003f78fa4017cb\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f733c9d96b89a0889aea72fb1003f78fa4017cb\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9087485632475785712\", \"scheduler_job_id:nacl/linux-pnacl-x86_32-tests-mips\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.nacl.toolchain\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"nacl\", \"id\": \"8922055569992767392\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"9f733c9d96b89a0889aea72fb1003f78fa4017cb\", \"bot_id\": \"gce-trusty-16-145e5bab-us-west1-c-141h\"}}",
"service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1549667814077482",
"status": "COMPLETED",
"status_changed_ts": "1549669426247646",
"tags": [
"build_address:luci.nacl.toolchain/linux-pnacl-x86_32-tests-mips/4958",
"builder:linux-pnacl-x86_32-tests-mips",
"buildset:commit/git/9f733c9d96b89a0889aea72fb1003f78fa4017cb",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f733c9d96b89a0889aea72fb1003f78fa4017cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9087485632475785712",
"scheduler_job_id:nacl/linux-pnacl-x86_32-tests-mips",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8922055569992767392/+/annotations",
"swarming_tag:luci_project:nacl",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:nacl",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:42e7dbb118298110",
"user_agent:luci-scheduler"
],
"updated_ts": "1549669426249124",
"url": "https://ci.chromium.org/b/8922055569992767392",
"utcnow_ts": "1549669426577317"
}
}
[23:43:46.588] Invocation finished in 2h7m32.783205117s with status SUCCEEDED