[23:52:52.115] New invocation is queued and will start shortly
[23:52:53.242] Starting the invocation (attempt 1)
[23:52:53.288] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:52:53.289] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:52:53.289] Buildbucket request:
{
"bucket": "luci.v8.try.triggered",
"client_operation_id": "9084396739084557920",
"parameters_json": "{\"builder_name\":\"v8_verify_flakes\",\"properties\":{}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:v8_verify_flakes",
"scheduler_invocation_id:9084396739084557920",
"scheduler_job_id:v8/v8_verify_flakes",
"user_agent:luci-scheduler"
]
}
[23:52:54.133] Buildbucket response:
{
"build": {
"bucket": "luci.v8.try.triggered",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552607573400027",
"id": "8918966677072321472",
"lease_expiration_ts": "1552731774003735",
"lease_key": "1830425393",
"parameters_json": "{\"builder_name\": \"v8_verify_flakes\", \"properties\": {}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-try-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552607574005246",
"tags": [
"builder:v8_verify_flakes",
"scheduler_invocation_id:9084396739084557920",
"scheduler_job_id:v8/v8_verify_flakes",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8918966677072321472/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:recipe_name:v8/verify_flakes",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:439770ff47784410",
"user_agent:luci-scheduler"
],
"updated_ts": "1552607574005335",
"url": "https://ci.chromium.org/b/8918966677072321472",
"utcnow_ts": "1552607574117453"
}
}
[23:52:54.133] Task URL: https://ci.chromium.org/b/8918966677072321472
[23:52:54.133] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:2:0) after 1m0s
[23:52:56.628] Received PubSub notification, asking Buildbucket for the build status
[23:52:56.792] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:54.157] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:2:0)
[23:53:54.157] Timer tick, asking Buildbucket for the build status
[23:53:54.325] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:54.325] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:4:0) after 1m0s
[23:54:54.341] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:4:0)
[23:54:54.341] Timer tick, asking Buildbucket for the build status
[23:54:54.430] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:54.430] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:5:0) after 1m0s
[23:55:54.414] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:5:0)
[23:55:54.414] Timer tick, asking Buildbucket for the build status
[23:55:54.460] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:54.460] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:6:0) after 1m0s
[23:56:54.478] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:6:0)
[23:56:54.478] Timer tick, asking Buildbucket for the build status
[23:56:54.541] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:54.541] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:7:0) after 1m0s
[23:57:54.551] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:7:0)
[23:57:54.551] Timer tick, asking Buildbucket for the build status
[23:57:57.417] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:57.417] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:8:0) after 1m0s
[23:58:57.399] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:8:0)
[23:58:57.399] Timer tick, asking Buildbucket for the build status
[23:58:57.461] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:57.461] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:9:0) after 1m0s
[23:59:57.480] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:9:0)
[23:59:57.480] Timer tick, asking Buildbucket for the build status
[23:59:57.524] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:57.524] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:10:0) after 1m0s
[00:00:57.567] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:10:0)
[00:00:57.567] Timer tick, asking Buildbucket for the build status
[00:00:57.616] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:57.616] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:11:0) after 1m0s
[00:01:57.649] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:11:0)
[00:01:57.649] Timer tick, asking Buildbucket for the build status
[00:01:57.700] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:57.700] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:12:0) after 1m0s
[00:02:57.728] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:12:0)
[00:02:57.728] Timer tick, asking Buildbucket for the build status
[00:02:57.792] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:57.792] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:13:0) after 1m0s
[00:03:57.807] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:13:0)
[00:03:57.807] Timer tick, asking Buildbucket for the build status
[00:03:57.938] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:57.939] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:14:0) after 1m0s
[00:04:57.988] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:14:0)
[00:04:57.988] Timer tick, asking Buildbucket for the build status
[00:04:58.142] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:58.142] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:15:0) after 1m0s
[00:05:58.165] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:15:0)
[00:05:58.165] Timer tick, asking Buildbucket for the build status
[00:05:58.284] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:58.284] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:16:0) after 1m0s
[00:06:58.298] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:16:0)
[00:06:58.298] Timer tick, asking Buildbucket for the build status
[00:06:58.413] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:58.413] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:17:0) after 1m0s
[00:07:58.425] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:17:0)
[00:07:58.425] Timer tick, asking Buildbucket for the build status
[00:07:58.505] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:58.505] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:18:0) after 1m0s
[00:08:58.524] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:18:0)
[00:08:58.524] Timer tick, asking Buildbucket for the build status
[00:08:58.589] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:58.589] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:19:0) after 1m0s
[00:09:58.609] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:19:0)
[00:09:58.609] Timer tick, asking Buildbucket for the build status
[00:09:58.717] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:58.717] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:20:0) after 1m0s
[00:10:58.738] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:20:0)
[00:10:58.738] Timer tick, asking Buildbucket for the build status
[00:10:59.121] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:59.121] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:21:0) after 1m0s
[00:11:59.097] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:21:0)
[00:11:59.097] Timer tick, asking Buildbucket for the build status
[00:11:59.287] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:59.287] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:22:0) after 1m0s
[00:12:59.293] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:22:0)
[00:12:59.293] Timer tick, asking Buildbucket for the build status
[00:12:59.347] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:59.347] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:23:0) after 1m0s
[00:13:59.371] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:23:0)
[00:13:59.371] Timer tick, asking Buildbucket for the build status
[00:13:59.428] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:59.428] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:24:0) after 1m0s
[00:14:59.449] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:24:0)
[00:14:59.449] Timer tick, asking Buildbucket for the build status
[00:14:59.781] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:59.781] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:25:0) after 1m0s
[00:15:59.789] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:25:0)
[00:15:59.789] Timer tick, asking Buildbucket for the build status
[00:15:59.914] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:59.914] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:26:0) after 1m0s
[00:16:59.936] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:26:0)
[00:16:59.936] Timer tick, asking Buildbucket for the build status
[00:16:59.988] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:59.988] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:27:0) after 1m0s
[00:18:00.052] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:27:0)
[00:18:00.052] Timer tick, asking Buildbucket for the build status
[00:18:00.194] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:00.194] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:28:0) after 1m0s
[00:19:00.220] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:28:0)
[00:19:00.220] Timer tick, asking Buildbucket for the build status
[00:19:00.265] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:00.265] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:29:0) after 1m0s
[00:20:00.292] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:29:0)
[00:20:00.292] Timer tick, asking Buildbucket for the build status
[00:20:00.379] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:00.379] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:30:0) after 1m0s
[00:21:00.419] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:30:0)
[00:21:00.419] Timer tick, asking Buildbucket for the build status
[00:21:00.551] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:00.551] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:31:0) after 1m0s
[00:22:00.572] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:31:0)
[00:22:00.572] Timer tick, asking Buildbucket for the build status
[00:22:00.628] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:00.628] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:32:0) after 1m0s
[00:23:00.645] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:32:0)
[00:23:00.645] Timer tick, asking Buildbucket for the build status
[00:23:00.787] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:00.787] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:33:0) after 1m0s
[00:24:00.763] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:33:0)
[00:24:00.763] Timer tick, asking Buildbucket for the build status
[00:24:00.893] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:00.893] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:34:0) after 1m0s
[00:25:00.915] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:34:0)
[00:25:00.915] Timer tick, asking Buildbucket for the build status
[00:25:01.089] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:01.089] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:35:0) after 1m0s
[00:26:01.093] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:35:0)
[00:26:01.093] Timer tick, asking Buildbucket for the build status
[00:26:01.510] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:01.510] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:36:0) after 1m0s
[00:27:01.495] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:36:0)
[00:27:01.495] Timer tick, asking Buildbucket for the build status
[00:27:01.553] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:01.553] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:37:0) after 1m0s
[00:28:01.548] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:37:0)
[00:28:01.548] Timer tick, asking Buildbucket for the build status
[00:28:01.652] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:01.652] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:38:0) after 1m0s
[00:29:01.659] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:38:0)
[00:29:01.659] Timer tick, asking Buildbucket for the build status
[00:29:01.824] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:01.824] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:39:0) after 1m0s
[00:30:01.834] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:39:0)
[00:30:01.834] Timer tick, asking Buildbucket for the build status
[00:30:01.990] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:01.990] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:40:0) after 1m0s
[00:31:01.971] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:40:0)
[00:31:01.971] Timer tick, asking Buildbucket for the build status
[00:31:02.236] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:02.236] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:41:0) after 1m0s
[00:32:02.246] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:41:0)
[00:32:02.246] Timer tick, asking Buildbucket for the build status
[00:32:02.559] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:02.559] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:42:0) after 1m0s
[00:33:02.556] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:42:0)
[00:33:02.556] Timer tick, asking Buildbucket for the build status
[00:33:02.613] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:02.613] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:43:0) after 1m0s
[00:34:02.605] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:43:0)
[00:34:02.605] Timer tick, asking Buildbucket for the build status
[00:34:02.656] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:02.656] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:44:0) after 1m0s
[00:35:02.631] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:44:0)
[00:35:02.631] Timer tick, asking Buildbucket for the build status
[00:35:02.923] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:02.923] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:45:0) after 1m0s
[00:36:02.938] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:45:0)
[00:36:02.938] Timer tick, asking Buildbucket for the build status
[00:36:03.062] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:03.062] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:46:0) after 1m0s
[00:37:03.082] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:46:0)
[00:37:03.082] Timer tick, asking Buildbucket for the build status
[00:37:03.155] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:03.155] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:47:0) after 1m0s
[00:38:03.178] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:47:0)
[00:38:03.178] Timer tick, asking Buildbucket for the build status
[00:38:03.227] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:03.227] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:48:0) after 1m0s
[00:39:03.216] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:48:0)
[00:39:03.216] Timer tick, asking Buildbucket for the build status
[00:39:03.293] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:03.293] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:49:0) after 1m0s
[00:40:09.501] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:49:0)
[00:40:09.501] Timer tick, asking Buildbucket for the build status
[00:40:09.606] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:09.606] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:50:0) after 1m0s
[00:41:09.626] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:50:0)
[00:41:09.626] Timer tick, asking Buildbucket for the build status
[00:41:09.832] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:09.832] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:51:0) after 1m0s
[00:42:09.867] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:51:0)
[00:42:09.867] Timer tick, asking Buildbucket for the build status
[00:42:09.943] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:09.943] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:52:0) after 1m0s
[00:43:09.964] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:52:0)
[00:43:09.965] Timer tick, asking Buildbucket for the build status
[00:43:10.031] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:10.031] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:53:0) after 1m0s
[00:44:10.031] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:53:0)
[00:44:10.031] Timer tick, asking Buildbucket for the build status
[00:44:10.104] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:10.104] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:54:0) after 1m0s
[00:45:10.105] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:54:0)
[00:45:10.105] Timer tick, asking Buildbucket for the build status
[00:45:10.219] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:10.219] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:55:0) after 1m0s
[00:46:10.203] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:55:0)
[00:46:10.203] Timer tick, asking Buildbucket for the build status
[00:46:10.247] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:10.247] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:56:0) after 1m0s
[00:47:10.257] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:56:0)
[00:47:10.257] Timer tick, asking Buildbucket for the build status
[00:47:10.305] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:10.305] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:57:0) after 1m0s
[00:48:10.328] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:57:0)
[00:48:10.328] Timer tick, asking Buildbucket for the build status
[00:48:10.617] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:10.617] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:58:0) after 1m0s
[00:49:10.635] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:58:0)
[00:49:10.635] Timer tick, asking Buildbucket for the build status
[00:49:10.754] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:10.754] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:59:0) after 1m0s
[00:50:10.779] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:59:0)
[00:50:10.779] Timer tick, asking Buildbucket for the build status
[00:50:11.016] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:11.016] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:60:0) after 1m0s
[00:51:11.026] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:60:0)
[00:51:11.026] Timer tick, asking Buildbucket for the build status
[00:51:11.074] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:11.074] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:61:0) after 1m0s
[00:52:11.092] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:61:0)
[00:52:11.092] Timer tick, asking Buildbucket for the build status
[00:52:11.156] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:11.156] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:62:0) after 1m0s
[00:53:11.154] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:62:0)
[00:53:11.154] Timer tick, asking Buildbucket for the build status
[00:53:11.246] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:11.246] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:63:0) after 1m0s
[00:54:11.263] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:63:0)
[00:54:11.263] Timer tick, asking Buildbucket for the build status
[00:54:11.417] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:11.417] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:64:0) after 1m0s
[00:55:11.424] Handling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:64:0)
[00:55:11.424] Timer tick, asking Buildbucket for the build status
[00:55:11.573] Build 8918966677072321472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:11.573] Scheduling timer "check-buildbucket-build-status" (v8/v8_verify_flakes:9084396739084557920:65:0) after 1m0s
[00:55:23.333] Received PubSub notification, asking Buildbucket for the build status
[00:55:23.371] Build 8918966677072321472: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[00:55:23.371] Buildbucket build:
{
"build": {
"bucket": "luci.v8.try.triggered",
"canary_preference": "AUTO",
"completed_ts": "1552611322534950",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552607573400027",
"failure_reason": "INFRA_FAILURE",
"id": "8918966677072321472",
"parameters_json": "{\"builder_name\": \"v8_verify_flakes\", \"properties\": {}}",
"project": "v8",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-f\"], \"inside_docker\": [\"1\", \"stock\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"kvm\": [\"0\"], \"gpu\": [\"none\"], \"id\": [\"swarm-docker-2-c4--020\"], \"server_version\": [\"4201-b04f7f8\"], \"machine_type\": [\"n1-standard-8\"], \"cores\": [\"8\"], \"host_class\": [\"multibot\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Ivy_Bridge_GCE\"], \"pool\": [\"luci.v8.try\"], \"caches\": [\"git\", \"goma_v2\", \"v8_builder_cache_nowait\", \"vpython\"]}}, \"ui\": {\"info\": \"Failure store\\nFailure FunctionCallSample\\nFailure Uncaught Exception\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"buildername\": \"v8_verify_flakes\", \"recipe\": \"v8/verify_flakes\", \"mastername\": \"tryserver.v8\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"path_config\": \"generic\", \"bot_id\": \"swarm-docker-2-c4--020\"}}",
"service_account": "v8-try-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1552607575789291",
"status": "COMPLETED",
"status_changed_ts": "1552611323096088",
"tags": [
"builder:v8_verify_flakes",
"scheduler_invocation_id:9084396739084557920",
"scheduler_job_id:v8/v8_verify_flakes",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8918966677072321472/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:v8/verify_flakes",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:439770ff47784410",
"user_agent:luci-scheduler"
],
"updated_ts": "1552611323101847",
"url": "https://ci.chromium.org/b/8918966677072321472",
"utcnow_ts": "1552611323360857"
}
}
[00:55:23.371] Invocation finished in 1h2m31.272751106s with status FAILED