[23:06:49.678] New invocation is queued and will start shortly
[23:06:50.811] Starting the invocation (attempt 1)
[23:06:50.855] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:06:50.856] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:06:50.856] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9023518474317070544",
"parameters_json": "{\"builder_name\":\"V8 Linux64 ASAN\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"e451d996fb398622bdf73fbb5757bb95c445963b\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\",\"title\":\"e451d996fb398622bdf73fbb5757bb95c445963b\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"e451d996fb398622bdf73fbb5757bb95c445963b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Linux64 ASAN",
"scheduler_invocation_id:9023518474317070544",
"scheduler_job_id:v8/ci-V8 Linux64 ASAN",
"user_agent:luci-scheduler",
"buildset:commit/git/e451d996fb398622bdf73fbb5757bb95c445963b",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b",
"gitiles_ref:refs/heads/master"
]
}
[23:07:20.738] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body:
<html><head>
<meta http-equiv="content-type" content="text/html;charset=utf-8">
<title>500 Server Error</title>
</head>
<body text=#000000 bgcolor=#ffffff>
<h1>Error: Server Error</h1>
<h2>The server encountered an error and could not complete your request.<p>Please try again in 30 seconds.</h2>
<h2></h2>
</body></html>
[23:07:20.738] The invocation will be retried
[23:07:25.798] Starting the invocation (attempt 2)
[23:07:25.835] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:07:25.835] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:07:25.835] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9023518474317070544",
"parameters_json": "{\"builder_name\":\"V8 Linux64 ASAN\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"e451d996fb398622bdf73fbb5757bb95c445963b\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\",\"title\":\"e451d996fb398622bdf73fbb5757bb95c445963b\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"e451d996fb398622bdf73fbb5757bb95c445963b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Linux64 ASAN",
"scheduler_invocation_id:9023518474317070544",
"scheduler_job_id:v8/ci-V8 Linux64 ASAN",
"user_agent:luci-scheduler",
"buildset:commit/git/e451d996fb398622bdf73fbb5757bb95c445963b",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b",
"gitiles_ref:refs/heads/master"
]
}
[23:07:27.264] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1610665645972148",
"id": "8858088375567886016",
"parameters_json": "{\"builder_name\": \"V8 Linux64 ASAN\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\", \"title\": \"e451d996fb398622bdf73fbb5757bb95c445963b\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610665646930705",
"tags": [
"build_address:luci.v8.ci/V8 Linux64 ASAN/38438",
"builder:V8 Linux64 ASAN",
"buildset:commit/git/e451d996fb398622bdf73fbb5757bb95c445963b",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023518474317070544",
"scheduler_job_id:v8/ci-V8 Linux64 ASAN",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8858088375567886016/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1610665646930868",
"url": "https://ci.chromium.org/b/8858088375567886016",
"utcnow_ts": "1610665647232579"
}
}
[23:07:27.264] Task URL: https://ci.chromium.org/b/8858088375567886016
[23:07:27.264] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:5:0) after 1m0s
[23:08:10.839] Received PubSub notification, asking Buildbucket for the build status
[23:08:10.934] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:27.399] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:5:0)
[23:08:27.400] Timer tick, asking Buildbucket for the build status
[23:08:27.711] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:27.711] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:7:0) after 1m0s
[23:09:27.983] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:7:0)
[23:09:27.983] Timer tick, asking Buildbucket for the build status
[23:09:28.102] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:28.102] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:8:0) after 1m0s
[23:10:28.219] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:8:0)
[23:10:28.219] Timer tick, asking Buildbucket for the build status
[23:10:28.353] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:28.353] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:9:0) after 1m0s
[23:11:28.494] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:9:0)
[23:11:28.494] Timer tick, asking Buildbucket for the build status
[23:11:28.593] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:28.593] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:10:0) after 1m0s
[23:12:28.622] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:10:0)
[23:12:28.622] Timer tick, asking Buildbucket for the build status
[23:12:28.780] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:28.780] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:11:0) after 1m0s
[23:13:28.934] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:11:0)
[23:13:28.934] Timer tick, asking Buildbucket for the build status
[23:13:29.114] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:29.114] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:12:0) after 1m0s
[23:14:29.163] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:12:0)
[23:14:29.163] Timer tick, asking Buildbucket for the build status
[23:14:29.292] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:29.292] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:13:0) after 1m0s
[23:15:29.316] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:13:0)
[23:15:29.316] Timer tick, asking Buildbucket for the build status
[23:15:29.383] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:29.383] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:14:0) after 1m0s
[23:16:29.473] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:14:0)
[23:16:29.473] Timer tick, asking Buildbucket for the build status
[23:16:29.691] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:29.692] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:15:0) after 1m0s
[23:17:29.745] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:15:0)
[23:17:29.745] Timer tick, asking Buildbucket for the build status
[23:17:30.718] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:30.718] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:16:0) after 1m0s
[23:18:30.738] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:16:0)
[23:18:30.738] Timer tick, asking Buildbucket for the build status
[23:18:30.831] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:30.831] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:17:0) after 1m0s
[23:19:30.873] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:17:0)
[23:19:30.873] Timer tick, asking Buildbucket for the build status
[23:19:30.945] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:30.945] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:18:0) after 1m0s
[23:20:31.134] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:18:0)
[23:20:31.134] Timer tick, asking Buildbucket for the build status
[23:20:31.204] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:31.204] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:19:0) after 1m0s
[23:21:31.272] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:19:0)
[23:21:31.272] Timer tick, asking Buildbucket for the build status
[23:21:31.352] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:31.352] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:20:0) after 1m0s
[23:22:31.345] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:20:0)
[23:22:31.345] Timer tick, asking Buildbucket for the build status
[23:22:34.161] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:34.161] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:21:0) after 1m0s
[23:23:34.159] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:21:0)
[23:23:34.159] Timer tick, asking Buildbucket for the build status
[23:23:34.223] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:34.223] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:22:0) after 1m0s
[23:24:34.239] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:22:0)
[23:24:34.240] Timer tick, asking Buildbucket for the build status
[23:24:34.376] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:34.376] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:23:0) after 1m0s
[23:25:34.443] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:23:0)
[23:25:34.443] Timer tick, asking Buildbucket for the build status
[23:25:34.506] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:34.506] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:24:0) after 1m0s
[23:26:34.553] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:24:0)
[23:26:34.553] Timer tick, asking Buildbucket for the build status
[23:26:34.609] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:34.609] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:25:0) after 1m0s
[23:27:34.661] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:25:0)
[23:27:34.661] Timer tick, asking Buildbucket for the build status
[23:27:34.982] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:34.982] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:26:0) after 1m0s
[23:28:35.028] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:26:0)
[23:28:35.028] Timer tick, asking Buildbucket for the build status
[23:28:35.097] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:35.097] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:27:0) after 1m0s
[23:29:35.100] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:27:0)
[23:29:35.100] Timer tick, asking Buildbucket for the build status
[23:29:35.166] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:35.166] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:28:0) after 1m0s
[23:30:35.205] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:28:0)
[23:30:35.205] Timer tick, asking Buildbucket for the build status
[23:30:35.288] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:35.288] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:29:0) after 1m0s
[23:31:35.405] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:29:0)
[23:31:35.405] Timer tick, asking Buildbucket for the build status
[23:31:35.471] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:35.471] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:30:0) after 1m0s
[23:32:35.465] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:30:0)
[23:32:35.465] Timer tick, asking Buildbucket for the build status
[23:32:35.608] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:35.608] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:31:0) after 1m0s
[23:33:35.643] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:31:0)
[23:33:35.643] Timer tick, asking Buildbucket for the build status
[23:33:35.845] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:35.845] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:32:0) after 1m0s
[23:34:35.885] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:32:0)
[23:34:35.885] Timer tick, asking Buildbucket for the build status
[23:34:35.962] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:35.962] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:33:0) after 1m0s
[23:35:35.981] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:33:0)
[23:35:35.981] Timer tick, asking Buildbucket for the build status
[23:35:36.133] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:36.133] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:34:0) after 1m0s
[23:36:36.116] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:34:0)
[23:36:36.116] Timer tick, asking Buildbucket for the build status
[23:36:36.602] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:36.602] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:35:0) after 1m0s
[23:37:36.649] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:35:0)
[23:37:36.649] Timer tick, asking Buildbucket for the build status
[23:37:36.836] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:36.836] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:36:0) after 1m0s
[23:38:36.906] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:36:0)
[23:38:36.906] Timer tick, asking Buildbucket for the build status
[23:38:36.996] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:36.996] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:37:0) after 1m0s
[23:39:37.038] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:37:0)
[23:39:37.038] Timer tick, asking Buildbucket for the build status
[23:39:37.109] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:37.109] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:38:0) after 1m0s
[23:40:37.101] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:38:0)
[23:40:37.101] Timer tick, asking Buildbucket for the build status
[23:40:38.283] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:38.283] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:39:0) after 1m0s
[23:41:38.288] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:39:0)
[23:41:38.288] Timer tick, asking Buildbucket for the build status
[23:41:38.346] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:38.346] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:40:0) after 1m0s
[23:42:38.398] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:40:0)
[23:42:38.398] Timer tick, asking Buildbucket for the build status
[23:42:38.504] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:38.504] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:41:0) after 1m0s
[23:43:38.564] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:41:0)
[23:43:38.564] Timer tick, asking Buildbucket for the build status
[23:43:38.732] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:38.732] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:42:0) after 1m0s
[23:44:38.771] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:42:0)
[23:44:38.771] Timer tick, asking Buildbucket for the build status
[23:44:38.837] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:38.837] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:43:0) after 1m0s
[23:45:38.882] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:43:0)
[23:45:38.882] Timer tick, asking Buildbucket for the build status
[23:45:39.151] Build 8858088375567886016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:39.151] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 ASAN:9023518474317070544:44:0) after 1m0s
[23:46:26.399] Received PubSub notification, asking Buildbucket for the build status
[23:46:26.795] Build 8858088375567886016: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:46:26.795] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1610667985388484",
"created_by": "project:v8",
"created_ts": "1610665645972148",
"id": "8858088375567886016",
"parameters_json": "{\"builder_name\": \"V8 Linux64 ASAN\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\", \"title\": \"e451d996fb398622bdf73fbb5757bb95c445963b\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com/\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\", \"title\": \"e451d996fb398622bdf73fbb5757bb95c445963b\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]}, \"bot_id\": \"luci-v8-ci-xenial-47-8cie\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Linux64 ASAN\", \"buildnumber\": 38438, \"got_revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\", \"got_revision_cp\": \"refs/heads/master@{#72103}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"v8\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_e8d2d44c90d6dd6168a8751e7732a46c861a9b050ff8bfc0c39c1c133184e355_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-v8-ci-xenial-47-8cie\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.v8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610665690128348",
"status": "COMPLETED",
"status_changed_ts": "1610667985921396",
"tags": [
"build_address:luci.v8.ci/V8 Linux64 ASAN/38438",
"builder:V8 Linux64 ASAN",
"buildset:commit/git/e451d996fb398622bdf73fbb5757bb95c445963b",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023518474317070544",
"scheduler_job_id:v8/ci-V8 Linux64 ASAN",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8858088375567886016/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:511bf8ed310e0f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610667985998771",
"url": "https://ci.chromium.org/b/8858088375567886016",
"utcnow_ts": "1610667986731582"
}
}
[23:46:26.795] Invocation finished in 39m37.160534585s with status SUCCEEDED