[20:08:21.137] New invocation is queued and will start shortly
[20:08:26.328] Starting the invocation (attempt 1)
[20:08:26.363] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:08:26.363] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:08:26.363] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9035126114708987136",
"parameters_json": "{\"builder_name\":\"win-upload-perfetto\",\"properties\":{}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-upload-perfetto",
"scheduler_invocation_id:9035126114708987136",
"scheduler_job_id:chromium/win-upload-perfetto",
"user_agent:luci-scheduler"
]
}
[20:08:27.218] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1599595706463746",
"id": "8869696048457899968",
"parameters_json": "{\"builder_name\": \"win-upload-perfetto\", \"properties\": {}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599595707060906",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/1283",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9035126114708987136",
"scheduler_job_id:chromium/win-upload-perfetto",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8869696048457899968/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1599595707061053",
"url": "https://ci.chromium.org/b/8869696048457899968",
"utcnow_ts": "1599595707205187"
}
}
[20:08:27.218] Task URL: https://ci.chromium.org/b/8869696048457899968
[20:08:27.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:2:0) after 1m0s
[20:09:27.422] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:2:0)
[20:09:27.422] Timer tick, asking Buildbucket for the build status
[20:09:27.626] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:27.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:3:0) after 1m0s
[20:10:27.697] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:3:0)
[20:10:27.697] Timer tick, asking Buildbucket for the build status
[20:10:28.029] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:28.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:4:0) after 1m0s
[20:11:28.215] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:4:0)
[20:11:28.215] Timer tick, asking Buildbucket for the build status
[20:11:28.639] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:28.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:5:0) after 1m0s
[20:12:28.701] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:5:0)
[20:12:28.701] Timer tick, asking Buildbucket for the build status
[20:12:29.056] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:29.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:6:0) after 1m0s
[20:13:29.323] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:6:0)
[20:13:29.323] Timer tick, asking Buildbucket for the build status
[20:13:29.749] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:29.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:7:0) after 1m0s
[20:14:29.840] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:7:0)
[20:14:29.840] Timer tick, asking Buildbucket for the build status
[20:14:29.952] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:29.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:8:0) after 1m0s
[20:15:30.136] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:8:0)
[20:15:30.136] Timer tick, asking Buildbucket for the build status
[20:15:30.301] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:30.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:9:0) after 1m0s
[20:16:30.311] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:9:0)
[20:16:30.311] Timer tick, asking Buildbucket for the build status
[20:16:30.645] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:30.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:10:0) after 1m0s
[20:17:30.773] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:10:0)
[20:17:30.773] Timer tick, asking Buildbucket for the build status
[20:17:31.902] Build 8869696048457899968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:31.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:11:0) after 1m0s
[20:17:58.453] Received PubSub notification, asking Buildbucket for the build status
[20:17:58.714] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:31.963] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:11:0)
[20:18:31.963] Timer tick, asking Buildbucket for the build status
[20:18:32.265] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:32.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:13:0) after 1m0s
[20:19:32.369] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:13:0)
[20:19:32.369] Timer tick, asking Buildbucket for the build status
[20:19:32.549] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:32.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:14:0) after 1m0s
[20:20:32.566] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:14:0)
[20:20:32.566] Timer tick, asking Buildbucket for the build status
[20:20:33.098] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:33.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:15:0) after 1m0s
[20:21:33.203] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:15:0)
[20:21:33.203] Timer tick, asking Buildbucket for the build status
[20:21:33.442] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:33.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:16:0) after 1m0s
[20:22:33.478] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:16:0)
[20:22:33.478] Timer tick, asking Buildbucket for the build status
[20:22:33.577] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:33.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:17:0) after 1m0s
[20:23:33.902] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:17:0)
[20:23:33.902] Timer tick, asking Buildbucket for the build status
[20:23:34.321] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:34.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:18:0) after 1m0s
[20:24:34.397] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:18:0)
[20:24:34.397] Timer tick, asking Buildbucket for the build status
[20:24:35.293] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:35.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:19:0) after 1m0s
[20:25:35.478] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:19:0)
[20:25:35.478] Timer tick, asking Buildbucket for the build status
[20:25:35.846] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:35.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:20:0) after 1m0s
[20:26:35.863] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:20:0)
[20:26:35.863] Timer tick, asking Buildbucket for the build status
[20:26:35.934] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:35.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:21:0) after 1m0s
[20:27:35.964] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:21:0)
[20:27:35.964] Timer tick, asking Buildbucket for the build status
[20:27:36.325] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:36.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:22:0) after 1m0s
[20:28:36.427] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:22:0)
[20:28:36.427] Timer tick, asking Buildbucket for the build status
[20:28:36.545] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:36.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:23:0) after 1m0s
[20:29:36.596] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:23:0)
[20:29:36.596] Timer tick, asking Buildbucket for the build status
[20:29:36.778] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:36.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:24:0) after 1m0s
[20:30:36.839] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:24:0)
[20:30:36.839] Timer tick, asking Buildbucket for the build status
[20:30:36.972] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:36.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:25:0) after 1m0s
[20:31:37.127] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:25:0)
[20:31:37.127] Timer tick, asking Buildbucket for the build status
[20:31:37.305] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:37.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:26:0) after 1m0s
[20:32:37.348] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:26:0)
[20:32:37.348] Timer tick, asking Buildbucket for the build status
[20:32:37.459] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:37.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:27:0) after 1m0s
[20:33:37.522] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:27:0)
[20:33:37.522] Timer tick, asking Buildbucket for the build status
[20:33:37.937] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:37.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:28:0) after 1m0s
[20:34:37.951] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:28:0)
[20:34:37.951] Timer tick, asking Buildbucket for the build status
[20:34:38.077] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:38.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:29:0) after 1m0s
[20:35:38.130] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:29:0)
[20:35:38.130] Timer tick, asking Buildbucket for the build status
[20:35:38.248] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:38.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:30:0) after 1m0s
[20:36:38.299] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:30:0)
[20:36:38.299] Timer tick, asking Buildbucket for the build status
[20:36:38.416] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:38.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:31:0) after 1m0s
[20:37:38.451] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:31:0)
[20:37:38.451] Timer tick, asking Buildbucket for the build status
[20:37:38.613] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:38.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:32:0) after 1m0s
[20:38:38.677] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:32:0)
[20:38:38.677] Timer tick, asking Buildbucket for the build status
[20:38:39.191] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:39.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:33:0) after 1m0s
[20:39:39.260] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:33:0)
[20:39:39.260] Timer tick, asking Buildbucket for the build status
[20:39:39.359] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:39.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:34:0) after 1m0s
[20:40:39.521] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:34:0)
[20:40:39.521] Timer tick, asking Buildbucket for the build status
[20:40:39.747] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:39.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:35:0) after 1m0s
[20:41:40.107] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:35:0)
[20:41:40.107] Timer tick, asking Buildbucket for the build status
[20:41:40.175] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:40.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:36:0) after 1m0s
[20:42:40.263] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:36:0)
[20:42:40.263] Timer tick, asking Buildbucket for the build status
[20:42:40.436] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:40.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:37:0) after 1m0s
[20:43:40.528] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:37:0)
[20:43:40.528] Timer tick, asking Buildbucket for the build status
[20:43:40.988] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:40.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:38:0) after 1m0s
[20:44:41.187] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:38:0)
[20:44:41.187] Timer tick, asking Buildbucket for the build status
[20:44:41.334] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:41.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:39:0) after 1m0s
[20:45:41.402] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:39:0)
[20:45:41.402] Timer tick, asking Buildbucket for the build status
[20:45:41.595] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:41.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:40:0) after 1m0s
[20:46:41.662] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:40:0)
[20:46:41.662] Timer tick, asking Buildbucket for the build status
[20:46:42.740] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:42.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:41:0) after 1m0s
[20:47:42.851] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:41:0)
[20:47:42.851] Timer tick, asking Buildbucket for the build status
[20:47:44.273] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:44.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:42:0) after 1m0s
[20:48:44.308] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:42:0)
[20:48:44.308] Timer tick, asking Buildbucket for the build status
[20:48:44.450] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:44.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:43:0) after 1m0s
[20:49:44.474] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:43:0)
[20:49:44.474] Timer tick, asking Buildbucket for the build status
[20:49:44.684] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:44.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:44:0) after 1m0s
[20:50:44.763] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:44:0)
[20:50:44.764] Timer tick, asking Buildbucket for the build status
[20:50:44.856] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:44.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:45:0) after 1m0s
[20:51:44.945] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:45:0)
[20:51:44.945] Timer tick, asking Buildbucket for the build status
[20:51:45.045] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:45.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:46:0) after 1m0s
[20:52:45.277] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:46:0)
[20:52:45.278] Timer tick, asking Buildbucket for the build status
[20:52:45.617] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:45.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:47:0) after 1m0s
[20:53:45.636] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:47:0)
[20:53:45.636] Timer tick, asking Buildbucket for the build status
[20:53:46.142] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:46.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:48:0) after 1m0s
[20:54:46.214] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:48:0)
[20:54:46.214] Timer tick, asking Buildbucket for the build status
[20:54:46.293] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:46.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:49:0) after 1m0s
[20:55:46.324] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:49:0)
[20:55:46.324] Timer tick, asking Buildbucket for the build status
[20:55:46.458] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:46.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:50:0) after 1m0s
[20:56:46.497] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:50:0)
[20:56:46.497] Timer tick, asking Buildbucket for the build status
[20:56:46.591] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:46.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:51:0) after 1m0s
[20:57:46.595] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:51:0)
[20:57:46.595] Timer tick, asking Buildbucket for the build status
[20:57:47.220] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:47.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:52:0) after 1m0s
[20:58:47.572] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:52:0)
[20:58:47.572] Timer tick, asking Buildbucket for the build status
[20:58:47.844] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:47.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:53:0) after 1m0s
[20:59:47.823] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:53:0)
[20:59:47.823] Timer tick, asking Buildbucket for the build status
[20:59:47.889] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:47.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:54:0) after 1m0s
[21:00:47.976] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:54:0)
[21:00:47.976] Timer tick, asking Buildbucket for the build status
[21:00:48.085] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:48.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:55:0) after 1m0s
[21:01:48.164] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:55:0)
[21:01:48.164] Timer tick, asking Buildbucket for the build status
[21:01:48.355] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:48.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:56:0) after 1m0s
[21:02:48.464] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:56:0)
[21:02:48.464] Timer tick, asking Buildbucket for the build status
[21:02:48.609] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:48.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:57:0) after 1m0s
[21:03:48.661] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:57:0)
[21:03:48.661] Timer tick, asking Buildbucket for the build status
[21:03:49.213] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:49.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:58:0) after 1m0s
[21:04:49.281] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:58:0)
[21:04:49.281] Timer tick, asking Buildbucket for the build status
[21:04:49.849] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:49.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:59:0) after 1m0s
[21:05:49.891] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:59:0)
[21:05:49.891] Timer tick, asking Buildbucket for the build status
[21:05:50.075] Build 8869696048457899968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:50.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9035126114708987136:60:0) after 1m0s
[21:06:37.350] Received PubSub notification, asking Buildbucket for the build status
[21:06:37.422] Build 8869696048457899968: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:06:37.422] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1599599197090886",
"created_by": "project:chromium",
"created_ts": "1599595706463746",
"failure_reason": "BUILD_FAILURE",
"id": "8869696048457899968",
"parameters_json": "{\"builder_name\": \"win-upload-perfetto\", \"properties\": {}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**upload_trace_processor** failed.\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"eafd15793774e4c63bb6a0b35f41e008fd6fef59\", \"project\": \"chromium/src\"}], \"$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}, \"bot_id\": \"luci-chromium-ci-win10-8-20-0srt\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"win-upload-perfetto\", \"buildnumber\": 1283, \"got_angle_revision\": \"2d00262a1459db12f0fe02e9a3d46d537ff0ce7b\", \"got_dawn_revision\": \"62442aceb0fb8af0c1edd07b5f18b4ec181b8fbf\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"eafd15793774e4c63bb6a0b35f41e008fd6fef59\", \"got_revision_cp\": \"refs/heads/master@{#805059}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"10121443c16deb0435be8ea61be54e3bee1b9855\", \"got_v8_revision\": \"3e2d6551eed76b7bdafb278b44c630965a840da8\", \"got_v8_revision_cp\": \"refs/heads/8.7.75@{#1}\", \"got_webrtc_revision\": \"9e9c8b7155d49c2f38b82fe9c9707181c57073c9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32051}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"swarm_hashes\": {\"upload_trace_processor\": \"afd08277586d837085a339f1d67259e03da73399\"}, \"swarm_hashes_refs/heads/master(at){#805059}_without_patch\": {\"upload_trace_processor\": \"afd08277586d837085a339f1d67259e03da73399\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_005c76091fbb2ec818a8c9df104002809214fca54c9e24e91c9996a9ec481d93_v2\", \"builder_17a5aa5f0152369144ec0c36d36a063a8e90ecdcb9f98c3fc557ce123c67d9c8_v2\", \"builder_9f0da7013cf7d604bf8adf950b5391d3d2a11c9e561279a5c2be686d09c3416f_v2\", \"builder_c35e56c92b201f7a839dc762e2da72f8df23a6613d4e78c3b1e5720af1ff9280_v2\", \"builder_cdcec0d46397976337010a09810cfb2d3faed6371f672191ed7f22146917e89a_v2\", \"builder_cfc63bfc2c1df246643e8c5df4f35493f13e9963a6f437cc5b68a631aab31260_v2\", \"builder_ecb3734530d64f332f2f8909e99db4f73e676d4b11714f09ab18a5a3c30ca443_v2\", \"builder_f3260d08dd27d98c432aca7d81a4129ae12de1f0eeb212ba6c534ea5c7320452_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-8-20-0srt\"], \"image\": [\"chrome-win10-1703-20083100-22dcea0839e\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5513-ee65082\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**upload_trace_processor** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599596277825284",
"status": "COMPLETED",
"status_changed_ts": "1599596278143630",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/1283",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9035126114708987136",
"scheduler_job_id:chromium/win-upload-perfetto",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8869696048457899968/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4e88270473b31510",
"user_agent:luci-scheduler"
],
"updated_ts": "1599599197168322",
"url": "https://ci.chromium.org/b/8869696048457899968",
"utcnow_ts": "1599599197411496"
}
}
[21:06:37.423] Invocation finished in 58m16.304895211s with status FAILED