[23:53:20.495] New invocation is queued and will start shortly
[23:53:22.206] Starting the invocation (attempt 1)
[23:53:22.245] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:53:22.246] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:53:22.246] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9045077625911790000",
"parameters_json": "{\"builder_name\":\"V8 Blink Win\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@d48bbd5276861624a9ee3b43631ac1f9a3e868a5\",\"title\":\"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Blink Win",
"scheduler_invocation_id:9045077625911790000",
"scheduler_job_id:v8/V8 Blink Win",
"user_agent:luci-scheduler",
"buildset:commit/git/d48bbd5276861624a9ee3b43631ac1f9a3e868a5",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d48bbd5276861624a9ee3b43631ac1f9a3e868a5",
"gitiles_ref:refs/heads/master"
]
}
[23:53:23.983] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:v8",
"created_ts": "1590105202434074",
"id": "8879647563210801904",
"parameters_json": "{\"builder_name\": \"V8 Blink Win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@d48bbd5276861624a9ee3b43631ac1f9a3e868a5\", \"title\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1590105203688402",
"tags": [
"build_address:luci.v8.ci/V8 Blink Win/2535",
"builder:V8 Blink Win",
"buildset:commit/git/d48bbd5276861624a9ee3b43631ac1f9a3e868a5",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d48bbd5276861624a9ee3b43631ac1f9a3e868a5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045077625911790000",
"scheduler_job_id:v8/V8 Blink Win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8879647563210801904/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:recipe_name:chromium_integration",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1590105203688549",
"url": "https://ci.chromium.org/b/8879647563210801904",
"utcnow_ts": "1590105203964702"
}
}
[23:53:23.983] Task URL: https://ci.chromium.org/b/8879647563210801904
[23:53:23.983] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:2:0) after 1m0s
[23:53:27.554] Received PubSub notification, asking Buildbucket for the build status
[23:53:28.543] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:24.021] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:2:0)
[23:54:24.021] Timer tick, asking Buildbucket for the build status
[23:54:24.285] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:24.285] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:4:0) after 1m0s
[23:55:24.320] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:4:0)
[23:55:24.320] Timer tick, asking Buildbucket for the build status
[23:55:24.924] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:24.924] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:5:0) after 1m0s
[23:56:24.955] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:5:0)
[23:56:24.955] Timer tick, asking Buildbucket for the build status
[23:56:25.150] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:25.150] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:6:0) after 1m0s
[23:57:25.182] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:6:0)
[23:57:25.182] Timer tick, asking Buildbucket for the build status
[23:57:25.290] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:25.290] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:7:0) after 1m0s
[23:58:25.308] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:7:0)
[23:58:25.308] Timer tick, asking Buildbucket for the build status
[23:58:25.428] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:25.428] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:8:0) after 1m0s
[23:59:25.405] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:8:0)
[23:59:25.405] Timer tick, asking Buildbucket for the build status
[23:59:25.585] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:25.585] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:9:0) after 1m0s
[00:00:25.696] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:9:0)
[00:00:25.696] Timer tick, asking Buildbucket for the build status
[00:00:25.866] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:25.866] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:10:0) after 1m0s
[00:01:26.457] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:10:0)
[00:01:26.457] Timer tick, asking Buildbucket for the build status
[00:01:26.703] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:26.703] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:11:0) after 1m0s
[00:02:26.972] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:11:0)
[00:02:26.972] Timer tick, asking Buildbucket for the build status
[00:02:27.122] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:27.122] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:12:0) after 1m0s
[00:03:27.210] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:12:0)
[00:03:27.210] Timer tick, asking Buildbucket for the build status
[00:03:27.436] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:27.436] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:13:0) after 1m0s
[00:04:27.529] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:13:0)
[00:04:27.529] Timer tick, asking Buildbucket for the build status
[00:04:27.628] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:27.628] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:14:0) after 1m0s
[00:05:27.894] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:14:0)
[00:05:27.894] Timer tick, asking Buildbucket for the build status
[00:05:30.209] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:30.209] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:15:0) after 1m0s
[00:06:30.296] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:15:0)
[00:06:30.296] Timer tick, asking Buildbucket for the build status
[00:06:30.574] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:30.574] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:16:0) after 1m0s
[00:07:30.608] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:16:0)
[00:07:30.608] Timer tick, asking Buildbucket for the build status
[00:07:30.985] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:30.985] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:17:0) after 1m0s
[00:08:31.004] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:17:0)
[00:08:31.004] Timer tick, asking Buildbucket for the build status
[00:08:31.179] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:31.179] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:18:0) after 1m0s
[00:09:31.242] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:18:0)
[00:09:31.242] Timer tick, asking Buildbucket for the build status
[00:09:31.771] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:31.771] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:19:0) after 1m0s
[00:10:31.813] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:19:0)
[00:10:31.813] Timer tick, asking Buildbucket for the build status
[00:10:32.545] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:32.545] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:20:0) after 1m0s
[00:11:32.611] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:20:0)
[00:11:32.611] Timer tick, asking Buildbucket for the build status
[00:11:34.055] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:34.055] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:21:0) after 1m0s
[00:12:34.118] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:21:0)
[00:12:34.118] Timer tick, asking Buildbucket for the build status
[00:12:34.303] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:34.303] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:22:0) after 1m0s
[00:13:34.358] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:22:0)
[00:13:34.358] Timer tick, asking Buildbucket for the build status
[00:13:34.721] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:34.721] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:23:0) after 1m0s
[00:14:34.741] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:23:0)
[00:14:34.741] Timer tick, asking Buildbucket for the build status
[00:14:34.984] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:34.984] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:24:0) after 1m0s
[00:15:35.182] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:24:0)
[00:15:35.182] Timer tick, asking Buildbucket for the build status
[00:15:36.148] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:36.148] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:25:0) after 1m0s
[00:16:36.160] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:25:0)
[00:16:36.160] Timer tick, asking Buildbucket for the build status
[00:16:36.310] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:36.310] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:26:0) after 1m0s
[00:17:36.392] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:26:0)
[00:17:36.392] Timer tick, asking Buildbucket for the build status
[00:17:36.698] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:36.698] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:27:0) after 1m0s
[00:18:36.707] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:27:0)
[00:18:36.707] Timer tick, asking Buildbucket for the build status
[00:18:36.890] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:36.890] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:28:0) after 1m0s
[00:19:36.907] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:28:0)
[00:19:36.907] Timer tick, asking Buildbucket for the build status
[00:19:37.115] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:37.115] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:29:0) after 1m0s
[00:20:37.137] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:29:0)
[00:20:37.137] Timer tick, asking Buildbucket for the build status
[00:20:37.620] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:37.620] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:30:0) after 1m0s
[00:21:37.675] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:30:0)
[00:21:37.675] Timer tick, asking Buildbucket for the build status
[00:21:37.945] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:37.945] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:31:0) after 1m0s
[00:22:37.963] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:31:0)
[00:22:37.963] Timer tick, asking Buildbucket for the build status
[00:22:38.186] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:38.186] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:32:0) after 1m0s
[00:23:38.351] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:32:0)
[00:23:38.351] Timer tick, asking Buildbucket for the build status
[00:23:38.528] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:38.528] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:33:0) after 1m0s
[00:24:38.566] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:33:0)
[00:24:38.566] Timer tick, asking Buildbucket for the build status
[00:24:38.940] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:38.940] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:34:0) after 1m0s
[00:25:38.975] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:34:0)
[00:25:38.975] Timer tick, asking Buildbucket for the build status
[00:25:45.107] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:45.107] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:35:0) after 1m0s
[00:26:45.172] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:35:0)
[00:26:45.172] Timer tick, asking Buildbucket for the build status
[00:26:45.368] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:45.368] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:36:0) after 1m0s
[00:27:45.391] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:36:0)
[00:27:45.391] Timer tick, asking Buildbucket for the build status
[00:27:45.633] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:45.633] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:37:0) after 1m0s
[00:28:45.706] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:37:0)
[00:28:45.706] Timer tick, asking Buildbucket for the build status
[00:28:46.245] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:46.245] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:38:0) after 1m0s
[00:29:46.339] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:38:0)
[00:29:46.339] Timer tick, asking Buildbucket for the build status
[00:29:46.565] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:46.565] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:39:0) after 1m0s
[00:30:46.653] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:39:0)
[00:30:46.654] Timer tick, asking Buildbucket for the build status
[00:30:47.553] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:47.553] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:40:0) after 1m0s
[00:31:47.564] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:40:0)
[00:31:47.564] Timer tick, asking Buildbucket for the build status
[00:31:47.719] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:47.719] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:41:0) after 1m0s
[00:32:47.824] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:41:0)
[00:32:47.824] Timer tick, asking Buildbucket for the build status
[00:32:48.215] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:48.215] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:42:0) after 1m0s
[00:33:48.248] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:42:0)
[00:33:48.248] Timer tick, asking Buildbucket for the build status
[00:33:49.480] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:49.480] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:43:0) after 1m0s
[00:34:49.583] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:43:0)
[00:34:49.583] Timer tick, asking Buildbucket for the build status
[00:34:49.826] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:49.826] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:44:0) after 1m0s
[00:35:49.949] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:44:0)
[00:35:49.949] Timer tick, asking Buildbucket for the build status
[00:35:50.248] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:50.248] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:45:0) after 1m0s
[00:36:50.331] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:45:0)
[00:36:50.331] Timer tick, asking Buildbucket for the build status
[00:36:50.883] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:50.883] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:46:0) after 1m0s
[00:37:50.962] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:46:0)
[00:37:50.962] Timer tick, asking Buildbucket for the build status
[00:37:51.420] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:51.420] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:47:0) after 1m0s
[00:38:51.546] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:47:0)
[00:38:51.546] Timer tick, asking Buildbucket for the build status
[00:38:51.966] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:51.966] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:48:0) after 1m0s
[00:39:52.028] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:48:0)
[00:39:52.028] Timer tick, asking Buildbucket for the build status
[00:39:52.203] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:52.203] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:49:0) after 1m0s
[00:40:52.216] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:49:0)
[00:40:52.216] Timer tick, asking Buildbucket for the build status
[00:40:52.721] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:52.721] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:50:0) after 1m0s
[00:41:53.226] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:50:0)
[00:41:53.226] Timer tick, asking Buildbucket for the build status
[00:41:53.548] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:53.548] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:51:0) after 1m0s
[00:42:53.862] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:51:0)
[00:42:53.862] Timer tick, asking Buildbucket for the build status
[00:42:54.106] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:54.106] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:52:0) after 1m0s
[00:43:54.474] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:52:0)
[00:43:54.474] Timer tick, asking Buildbucket for the build status
[00:43:55.047] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:55.047] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:53:0) after 1m0s
[00:44:55.310] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:53:0)
[00:44:55.310] Timer tick, asking Buildbucket for the build status
[00:44:55.532] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:55.532] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:54:0) after 1m0s
[00:45:55.820] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:54:0)
[00:45:55.820] Timer tick, asking Buildbucket for the build status
[00:45:56.397] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:56.397] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:55:0) after 1m0s
[00:46:56.574] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:55:0)
[00:46:56.575] Timer tick, asking Buildbucket for the build status
[00:46:56.753] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:56.753] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:56:0) after 1m0s
[00:47:56.856] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:56:0)
[00:47:56.856] Timer tick, asking Buildbucket for the build status
[00:47:57.498] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:57.498] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:57:0) after 1m0s
[00:48:57.655] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:57:0)
[00:48:57.655] Timer tick, asking Buildbucket for the build status
[00:48:57.805] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:57.805] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:58:0) after 1m0s
[00:49:57.837] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:58:0)
[00:49:57.837] Timer tick, asking Buildbucket for the build status
[00:49:58.785] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:58.785] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:59:0) after 1m0s
[00:50:58.830] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:59:0)
[00:50:58.830] Timer tick, asking Buildbucket for the build status
[00:50:59.289] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:59.289] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:60:0) after 1m0s
[00:51:59.366] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:60:0)
[00:51:59.366] Timer tick, asking Buildbucket for the build status
[00:51:59.610] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:59.610] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:61:0) after 1m0s
[00:52:59.700] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:61:0)
[00:52:59.700] Timer tick, asking Buildbucket for the build status
[00:52:59.931] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:59.931] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:62:0) after 1m0s
[00:53:59.953] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:62:0)
[00:53:59.953] Timer tick, asking Buildbucket for the build status
[00:54:00.342] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:00.342] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:63:0) after 1m0s
[00:55:00.396] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:63:0)
[00:55:00.396] Timer tick, asking Buildbucket for the build status
[00:55:00.558] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:00.558] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:64:0) after 1m0s
[00:56:01.223] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:64:0)
[00:56:01.223] Timer tick, asking Buildbucket for the build status
[00:56:01.512] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:01.512] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:65:0) after 1m0s
[00:57:02.035] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:65:0)
[00:57:02.035] Timer tick, asking Buildbucket for the build status
[00:57:02.488] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:02.488] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:66:0) after 1m0s
[00:58:02.589] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:66:0)
[00:58:02.589] Timer tick, asking Buildbucket for the build status
[00:58:02.906] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:02.906] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:67:0) after 1m0s
[00:59:02.939] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:67:0)
[00:59:02.939] Timer tick, asking Buildbucket for the build status
[00:59:03.370] Build 8879647563210801904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:03.370] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9045077625911790000:68:0) after 1m0s
[00:59:04.168] Received PubSub notification, asking Buildbucket for the build status
[00:59:04.349] Build 8879647563210801904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:59:04.349] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1590109143168729",
"created_by": "project:v8",
"created_ts": "1590105202434074",
"id": "8879647563210801904",
"parameters_json": "{\"builder_name\": \"V8 Blink Win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@d48bbd5276861624a9ee3b43631ac1f9a3e868a5\", \"title\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@d48bbd5276861624a9ee3b43631ac1f9a3e868a5\", \"title\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/d48bbd5276861624a9ee3b43631ac1f9a3e868a5\"}]}, \"bot_id\": \"luci-v8-ci-win10-2-dfto\", \"branch\": \"refs/heads/master\", \"buildername\": \"V8 Blink Win\", \"buildnumber\": 2535, \"got_angle_revision\": \"93fc7d718e4c26d81d832a20de5e64953def0179\", \"got_cr_revision\": \"feca9db72bf171a32f724bb0328d24ade19ef778\", \"got_cr_revision_cp\": \"refs/heads/master@{#771259}\", \"got_dawn_revision\": \"bd0ad7921d3d6314898872029900fd964c2a6ed0\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"56b912f2f047b1df1dcbeebb1807ed15d17cf9dc\", \"got_revision_cp\": \"refs/heads/8.5.33@{#1}\", \"got_swarming_client_revision\": \"7e8636295f4763a5f5aace1e700b17a4af3c81b7\", \"got_swiftshader_revision\": \"cc5cda0f997d8280712920f2749bbdfe7a0f4dc3\", \"got_v8_revision\": \"56b912f2f047b1df1dcbeebb1807ed15d17cf9dc\", \"got_v8_revision_cp\": \"refs/heads/8.5.33@{#1}\", \"got_webrtc_revision\": \"3cc1a6509bf6143f9d52d76a7648a9c8d3bdccea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31336}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.v8.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium_integration\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d48bbd5276861624a9ee3b43631ac1f9a3e868a5\", \"swarm_hashes_refs/heads/8.5.33(at){#1}_without_patch\": {\"blink_web_tests\": \"2107ec285a2efc273f7afa29c8e8baf8bdaa53c7\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_1ba21d29072c773e64a4ad6c88c292daf588cd0545668ee7f927d2105b6dcb9e_v2\", \"builder_897aaefe1bffc20735d5eb376151a281864e1993e144bb0c5abf8be97bedab26_v2\", \"builder_c45cd84c3011deeeb1bb95553d013b3b691464b45620fcd454d65c09381ae99d_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-v8-ci-win10-2-dfto\"], \"image\": [\"chrome-win10-1703-20042500-5e6af220c3f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.v8.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5100-d2625c1\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1590105205928148",
"status": "COMPLETED",
"status_changed_ts": "1590109143597411",
"tags": [
"build_address:luci.v8.ci/V8 Blink Win/2535",
"builder:V8 Blink Win",
"buildset:commit/git/d48bbd5276861624a9ee3b43631ac1f9a3e868a5",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d48bbd5276861624a9ee3b43631ac1f9a3e868a5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045077625911790000",
"scheduler_job_id:v8/V8 Blink Win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8879647563210801904/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium_integration",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4c52796e6c92d510",
"user_agent:luci-scheduler"
],
"updated_ts": "1590109143633826",
"url": "https://ci.chromium.org/b/8879647563210801904",
"utcnow_ts": "1590109144321859"
}
}
[00:59:04.349] Invocation finished in 1h5m43.873993924s with status SUCCEEDED