[18:40:56.717] New invocation is queued and will start shortly
[18:40:57.911] Starting the invocation (attempt 1)
[18:40:57.995] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:40:57.995] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:40:57.995] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9017736996327837328",
"parameters_json": "{\"builder_name\":\"V8 Blink Linux Debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"0655aa0573da1e1e6911dc4b49d48becc542ed5e\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@0655aa0573da1e1e6911dc4b49d48becc542ed5e\",\"title\":\"0655aa0573da1e1e6911dc4b49d48becc542ed5e\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/0655aa0573da1e1e6911dc4b49d48becc542ed5e\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"0655aa0573da1e1e6911dc4b49d48becc542ed5e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Blink Linux Debug",
"scheduler_invocation_id:9017736996327837328",
"scheduler_job_id:v8/V8 Blink Linux Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/0655aa0573da1e1e6911dc4b49d48becc542ed5e",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/0655aa0573da1e1e6911dc4b49d48becc542ed5e",
"gitiles_ref:refs/heads/master"
]
}
[18:40:58.710] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1616179258122114",
"id": "8852306934194128784",
"parameters_json": "{\"builder_name\": \"V8 Blink Linux Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"0655aa0573da1e1e6911dc4b49d48becc542ed5e\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@0655aa0573da1e1e6911dc4b49d48becc542ed5e\", \"title\": \"0655aa0573da1e1e6911dc4b49d48becc542ed5e\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/0655aa0573da1e1e6911dc4b49d48becc542ed5e\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"0655aa0573da1e1e6911dc4b49d48becc542ed5e\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616179258513992",
"tags": [
"build_address:luci.v8.ci/V8 Blink Linux Debug/8685",
"builder:V8 Blink Linux Debug",
"buildset:commit/git/0655aa0573da1e1e6911dc4b49d48becc542ed5e",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/0655aa0573da1e1e6911dc4b49d48becc542ed5e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017736996327837328",
"scheduler_job_id:v8/V8 Blink Linux Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8852306934194128784/+/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": "1616179258514108",
"url": "https://ci.chromium.org/b/8852306934194128784",
"utcnow_ts": "1616179258699387"
}
}
[18:40:58.710] Task URL: https://ci.chromium.org/b/8852306934194128784
[18:40:58.710] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:2:0) after 1m0s
[18:41:58.725] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:2:0)
[18:41:58.725] Timer tick, asking Buildbucket for the build status
[18:41:58.809] Build 8852306934194128784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:58.809] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:3:0) after 1m0s
[18:42:58.794] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:3:0)
[18:42:58.836] Build status: SCHEDULED
[18:42:58.836] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:4:0) after 1m53s
[18:44:51.889] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:4:0)
[18:44:51.889] Timer tick, asking Buildbucket for the build status
[18:44:52.000] Build 8852306934194128784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:52.000] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:5:0) after 1m0s
[18:45:52.019] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:5:0)
[18:45:52.019] Timer tick, asking Buildbucket for the build status
[18:45:52.191] Build 8852306934194128784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:52.191] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:6:0) after 1m0s
[18:46:08.160] Received PubSub notification, asking Buildbucket for the build status
[18:46:08.327] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:52.211] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:6:0)
[18:46:52.211] Timer tick, asking Buildbucket for the build status
[18:46:52.319] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:52.320] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:8:0) after 1m0s
[18:47:52.337] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:8:0)
[18:47:52.337] Timer tick, asking Buildbucket for the build status
[18:47:52.405] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:52.405] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:9:0) after 1m0s
[18:48:52.469] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:9:0)
[18:48:52.495] Build status: STARTED
[18:48:52.495] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:10:0) after 2m58s
[18:51:50.570] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:10:0)
[18:51:50.570] Timer tick, asking Buildbucket for the build status
[18:51:50.654] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:50.654] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:11:0) after 1m0s
[18:52:50.748] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:11:0)
[18:52:50.748] Timer tick, asking Buildbucket for the build status
[18:52:50.832] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:50.832] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:12:0) after 1m0s
[18:53:50.869] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:12:0)
[18:53:50.958] Build status: STARTED
[18:53:50.958] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:13:0) after 2m29s
[18:56:19.981] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:13:0)
[18:56:19.981] Timer tick, asking Buildbucket for the build status
[18:56:20.103] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:20.103] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:14:0) after 1m0s
[18:57:20.122] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:14:0)
[18:57:20.122] Timer tick, asking Buildbucket for the build status
[18:57:20.377] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:20.377] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:15:0) after 1m0s
[18:58:20.397] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:15:0)
[18:58:20.397] Timer tick, asking Buildbucket for the build status
[18:58:20.470] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:20.470] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:16:0) after 1m0s
[18:59:20.489] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:16:0)
[18:59:20.516] Build status: STARTED
[18:59:20.516] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:17:0) after 3m34s
[19:02:54.544] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:17:0)
[19:02:54.578] Build status: STARTED
[19:02:54.578] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:18:0) after 1m8s
[19:04:02.609] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:18:0)
[19:04:02.791] Build status: STARTED
[19:04:02.791] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:19:0) after 3m20s
[19:07:22.809] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:19:0)
[19:07:22.809] Timer tick, asking Buildbucket for the build status
[19:07:22.918] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:22.918] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:20:0) after 1m0s
[19:08:22.993] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:20:0)
[19:08:23.018] Build status: STARTED
[19:08:23.018] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:21:0) after 6m42s
[19:15:05.069] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:21:0)
[19:15:05.069] Timer tick, asking Buildbucket for the build status
[19:15:05.151] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:05.151] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:22:0) after 1m0s
[19:16:05.177] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:22:0)
[19:16:05.204] Build status: STARTED
[19:16:05.204] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:23:0) after 5m28s
[19:21:33.224] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:23:0)
[19:21:33.267] Build status: STARTED
[19:21:33.267] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:24:0) after 6m19s
[19:27:52.297] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:24:0)
[19:27:52.297] Timer tick, asking Buildbucket for the build status
[19:27:52.432] Build 8852306934194128784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:52.432] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:25:0) after 1m0s
[19:28:52.449] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:25:0)
[19:28:52.476] Build status: STARTED
[19:28:52.476] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9017736996327837328:26:0) after 6m41s
[19:32:45.055] Received PubSub notification, asking Buildbucket for the build status
[19:32:45.088] Build:
{
"id": "8852306934194128784",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Linux Debug"
},
"number": 8685,
"createdBy": "project:v8",
"createTime": "2021-03-19T18:40:58.122114Z",
"startTime": "2021-03-19T18:46:07.347227Z",
"endTime": "2021-03-19T19:32:44.562881725Z",
"updateTime": "2021-03-19T19:32:44.563274895Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "0655aa0573da1e1e6911dc4b49d48becc542ed5e",
"ref": "refs/heads/master"
}
}
}
[19:32:45.088] Invocation finished in 51m48.384881121s with status SUCCEEDED