[01:53:42.912] New invocation is queued and will start shortly
[01:53:44.247] Starting the invocation (attempt 1)
[01:53:44.281] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:53:44.281] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:53:44.281] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018072156672399280",
"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:9018072156672399280",
"scheduler_job_id:chromium/win-upload-perfetto",
"user_agent:luci-scheduler"
]
}
[01:53:44.966] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615859624388002",
"id": "8852642094456172624",
"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": "1615859624777341",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/2459",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9018072156672399280",
"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/8852642094456172624/+/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": "1615859624777477",
"url": "https://ci.chromium.org/b/8852642094456172624",
"utcnow_ts": "1615859624959961"
}
}
[01:53:44.966] Task URL: https://ci.chromium.org/b/8852642094456172624
[01:53:44.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:2:0) after 1m0s
[01:54:45.051] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:2:0)
[01:54:45.051] Timer tick, asking Buildbucket for the build status
[01:54:45.121] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:45.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:3:0) after 1m0s
[01:55:45.233] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:3:0)
[01:55:45.233] Timer tick, asking Buildbucket for the build status
[01:55:45.292] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:45.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:4:0) after 1m0s
[01:56:45.305] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:4:0)
[01:56:45.305] Timer tick, asking Buildbucket for the build status
[01:56:45.423] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:45.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:5:0) after 1m0s
[01:57:45.446] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:5:0)
[01:57:45.446] Timer tick, asking Buildbucket for the build status
[01:57:45.517] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:45.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:6:0) after 1m0s
[01:58:45.522] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:6:0)
[01:58:45.522] Timer tick, asking Buildbucket for the build status
[01:58:45.588] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:45.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:7:0) after 1m0s
[01:59:45.670] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:7:0)
[01:59:45.670] Timer tick, asking Buildbucket for the build status
[01:59:45.732] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:45.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:8:0) after 1m0s
[02:00:45.788] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:8:0)
[02:00:45.788] Timer tick, asking Buildbucket for the build status
[02:00:46.571] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:46.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:9:0) after 1m0s
[02:01:46.628] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:9:0)
[02:01:46.628] Timer tick, asking Buildbucket for the build status
[02:01:46.731] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:46.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:10:0) after 1m0s
[02:02:46.809] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:10:0)
[02:02:46.809] Timer tick, asking Buildbucket for the build status
[02:02:46.903] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:46.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:11:0) after 1m0s
[02:03:47.035] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:11:0)
[02:03:47.035] Timer tick, asking Buildbucket for the build status
[02:03:47.117] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:47.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:12:0) after 1m0s
[02:04:47.271] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:12:0)
[02:04:47.271] Timer tick, asking Buildbucket for the build status
[02:04:47.337] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:47.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:13:0) after 1m0s
[02:05:47.350] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:13:0)
[02:05:47.350] Timer tick, asking Buildbucket for the build status
[02:05:47.615] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:47.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:14:0) after 1m0s
[02:06:47.776] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:14:0)
[02:06:47.776] Timer tick, asking Buildbucket for the build status
[02:06:47.853] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:47.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:15:0) after 1m0s
[02:07:47.943] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:15:0)
[02:07:47.943] Timer tick, asking Buildbucket for the build status
[02:07:48.013] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:48.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:16:0) after 1m0s
[02:08:48.311] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:16:0)
[02:08:48.311] Timer tick, asking Buildbucket for the build status
[02:08:48.727] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:48.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:17:0) after 1m0s
[02:09:48.757] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:17:0)
[02:09:48.757] Timer tick, asking Buildbucket for the build status
[02:09:48.828] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:48.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:18:0) after 1m0s
[02:10:48.843] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:18:0)
[02:10:48.843] Timer tick, asking Buildbucket for the build status
[02:10:49.208] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:49.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:19:0) after 1m0s
[02:11:49.223] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:19:0)
[02:11:49.224] Timer tick, asking Buildbucket for the build status
[02:11:49.320] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:49.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:20:0) after 1m0s
[02:12:49.334] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:20:0)
[02:12:49.334] Timer tick, asking Buildbucket for the build status
[02:12:49.437] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:49.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:21:0) after 1m0s
[02:13:49.472] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:21:0)
[02:13:49.472] Timer tick, asking Buildbucket for the build status
[02:13:49.543] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:49.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:22:0) after 1m0s
[02:14:49.533] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:22:0)
[02:14:49.533] Timer tick, asking Buildbucket for the build status
[02:14:49.603] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:49.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:23:0) after 1m0s
[02:15:49.620] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:23:0)
[02:15:49.620] Timer tick, asking Buildbucket for the build status
[02:15:49.694] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:49.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:24:0) after 1m0s
[02:16:49.689] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:24:0)
[02:16:49.689] Timer tick, asking Buildbucket for the build status
[02:16:50.026] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:50.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:25:0) after 1m0s
[02:17:50.064] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:25:0)
[02:17:50.064] Timer tick, asking Buildbucket for the build status
[02:17:50.125] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:50.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:26:0) after 1m0s
[02:18:50.143] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:26:0)
[02:18:50.143] Timer tick, asking Buildbucket for the build status
[02:18:50.555] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:50.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:27:0) after 1m0s
[02:19:50.579] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:27:0)
[02:19:50.579] Timer tick, asking Buildbucket for the build status
[02:19:50.730] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:50.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:28:0) after 1m0s
[02:20:50.774] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:28:0)
[02:20:50.774] Timer tick, asking Buildbucket for the build status
[02:20:53.830] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:53.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:29:0) after 1m0s
[02:21:53.901] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:29:0)
[02:21:53.901] Timer tick, asking Buildbucket for the build status
[02:21:53.976] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:53.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:30:0) after 1m0s
[02:22:54.013] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:30:0)
[02:22:54.013] Timer tick, asking Buildbucket for the build status
[02:22:54.077] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:54.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:31:0) after 1m0s
[02:23:54.057] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:31:0)
[02:23:54.057] Timer tick, asking Buildbucket for the build status
[02:23:54.164] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:54.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:32:0) after 1m0s
[02:24:54.179] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:32:0)
[02:24:54.179] Timer tick, asking Buildbucket for the build status
[02:24:54.258] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:54.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:33:0) after 1m0s
[02:25:54.272] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:33:0)
[02:25:54.272] Timer tick, asking Buildbucket for the build status
[02:25:54.349] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:54.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:34:0) after 1m0s
[02:26:54.431] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:34:0)
[02:26:54.431] Timer tick, asking Buildbucket for the build status
[02:26:54.531] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:54.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:35:0) after 1m0s
[02:27:54.600] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:35:0)
[02:27:54.600] Timer tick, asking Buildbucket for the build status
[02:27:54.673] Build 8852642094456172624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:54.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:36:0) after 1m0s
[02:28:27.579] Received PubSub notification, asking Buildbucket for the build status
[02:28:27.718] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:54.719] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:36:0)
[02:28:54.720] Timer tick, asking Buildbucket for the build status
[02:28:54.892] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:54.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:38:0) after 1m0s
[02:29:55.304] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:38:0)
[02:29:55.304] Timer tick, asking Buildbucket for the build status
[02:29:55.636] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:55.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:39:0) after 1m0s
[02:30:55.798] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:39:0)
[02:30:55.798] Timer tick, asking Buildbucket for the build status
[02:30:56.716] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:56.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:40:0) after 1m0s
[02:31:56.827] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:40:0)
[02:31:56.827] Timer tick, asking Buildbucket for the build status
[02:31:56.923] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:56.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:41:0) after 1m0s
[02:32:56.906] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:41:0)
[02:32:56.906] Timer tick, asking Buildbucket for the build status
[02:32:57.478] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:57.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:42:0) after 1m0s
[02:33:57.577] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:42:0)
[02:33:57.577] Timer tick, asking Buildbucket for the build status
[02:33:57.655] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:57.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:43:0) after 1m0s
[02:34:57.758] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:43:0)
[02:34:57.758] Timer tick, asking Buildbucket for the build status
[02:34:57.821] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:57.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:44:0) after 1m0s
[02:35:57.888] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:44:0)
[02:35:57.888] Timer tick, asking Buildbucket for the build status
[02:35:58.035] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:58.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:45:0) after 1m0s
[02:36:58.080] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:45:0)
[02:36:58.080] Timer tick, asking Buildbucket for the build status
[02:36:58.222] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:58.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:46:0) after 1m0s
[02:37:58.358] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:46:0)
[02:37:58.358] Timer tick, asking Buildbucket for the build status
[02:37:58.437] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:58.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:47:0) after 1m0s
[02:38:58.484] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:47:0)
[02:38:58.484] Timer tick, asking Buildbucket for the build status
[02:38:58.656] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:58.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:48:0) after 1m0s
[02:39:58.714] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:48:0)
[02:39:58.714] Timer tick, asking Buildbucket for the build status
[02:39:58.786] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:58.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:49:0) after 1m0s
[02:40:58.852] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:49:0)
[02:40:58.852] Timer tick, asking Buildbucket for the build status
[02:40:59.130] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:59.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:50:0) after 1m0s
[02:41:59.153] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:50:0)
[02:41:59.153] Timer tick, asking Buildbucket for the build status
[02:41:59.228] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:59.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:51:0) after 1m0s
[02:42:59.244] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:51:0)
[02:42:59.244] Timer tick, asking Buildbucket for the build status
[02:42:59.626] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:59.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:52:0) after 1m0s
[02:43:59.652] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:52:0)
[02:43:59.652] Timer tick, asking Buildbucket for the build status
[02:43:59.746] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:59.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:53:0) after 1m0s
[02:44:59.795] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:53:0)
[02:44:59.795] Timer tick, asking Buildbucket for the build status
[02:45:00.186] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:00.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:54:0) after 1m0s
[02:46:00.471] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:54:0)
[02:46:00.471] Timer tick, asking Buildbucket for the build status
[02:46:00.550] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:00.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:55:0) after 1m0s
[02:47:00.570] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:55:0)
[02:47:00.571] Timer tick, asking Buildbucket for the build status
[02:47:00.657] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:00.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:56:0) after 1m0s
[02:48:00.675] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:56:0)
[02:48:00.675] Timer tick, asking Buildbucket for the build status
[02:48:00.748] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:00.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:57:0) after 1m0s
[02:49:00.866] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:57:0)
[02:49:00.866] Timer tick, asking Buildbucket for the build status
[02:49:01.139] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:01.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:58:0) after 1m0s
[02:50:01.591] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:58:0)
[02:50:01.591] Timer tick, asking Buildbucket for the build status
[02:50:01.664] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:01.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:59:0) after 1m0s
[02:51:01.877] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:59:0)
[02:51:01.877] Timer tick, asking Buildbucket for the build status
[02:51:01.968] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:01.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:60:0) after 1m0s
[02:52:02.229] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:60:0)
[02:52:02.229] Timer tick, asking Buildbucket for the build status
[02:52:02.301] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:02.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:61:0) after 1m0s
[02:53:02.793] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:61:0)
[02:53:02.793] Timer tick, asking Buildbucket for the build status
[02:53:03.050] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:03.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:62:0) after 1m0s
[02:54:03.133] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:62:0)
[02:54:03.133] Timer tick, asking Buildbucket for the build status
[02:54:03.294] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:03.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:63:0) after 1m0s
[02:55:03.423] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:63:0)
[02:55:03.423] Timer tick, asking Buildbucket for the build status
[02:55:03.727] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:03.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:64:0) after 1m0s
[02:56:03.908] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:64:0)
[02:56:03.908] Timer tick, asking Buildbucket for the build status
[02:56:03.996] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:03.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:65:0) after 1m0s
[02:57:04.147] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:65:0)
[02:57:04.147] Timer tick, asking Buildbucket for the build status
[02:57:06.582] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:06.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:66:0) after 1m0s
[02:58:06.750] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:66:0)
[02:58:06.750] Timer tick, asking Buildbucket for the build status
[02:58:06.859] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:06.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:67:0) after 1m0s
[02:59:06.955] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:67:0)
[02:59:06.955] Timer tick, asking Buildbucket for the build status
[02:59:07.056] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:07.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:68:0) after 1m0s
[03:00:07.233] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:68:0)
[03:00:07.233] Timer tick, asking Buildbucket for the build status
[03:00:07.295] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:07.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:69:0) after 1m0s
[03:01:07.411] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:69:0)
[03:01:07.411] Timer tick, asking Buildbucket for the build status
[03:01:07.475] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:07.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:70:0) after 1m0s
[03:02:07.585] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:70:0)
[03:02:07.585] Timer tick, asking Buildbucket for the build status
[03:02:07.803] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:07.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:71:0) after 1m0s
[03:03:07.822] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:71:0)
[03:03:07.822] Timer tick, asking Buildbucket for the build status
[03:03:07.904] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:07.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:72:0) after 1m0s
[03:04:07.930] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:72:0)
[03:04:07.930] Timer tick, asking Buildbucket for the build status
[03:04:08.029] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:08.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:73:0) after 1m0s
[03:05:08.049] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:73:0)
[03:05:08.049] Timer tick, asking Buildbucket for the build status
[03:05:08.113] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:08.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:74:0) after 1m0s
[03:06:08.098] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:74:0)
[03:06:08.098] Timer tick, asking Buildbucket for the build status
[03:06:08.413] Build 8852642094456172624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:08.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9018072156672399280:75:0) after 1m0s
[03:06:22.026] Received PubSub notification, asking Buildbucket for the build status
[03:06:22.109] Build 8852642094456172624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:06:22.109] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615863981260167",
"created_by": "project:chromium",
"created_ts": "1615859624388002",
"id": "8852642094456172624",
"parameters_json": "{\"builder_name\": \"win-upload-perfetto\", \"properties\": {}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"4ce50f6cfcc40e7e6e2902fdeb798d5bd5070268\", \"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-3-r2dm\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"win-upload-perfetto\", \"buildnumber\": 2459, \"got_angle_revision\": \"687d3153197e5ef162e7bc75e931a09208ba3fe6\", \"got_dawn_revision\": \"8c40cad1c92d7e85154bbae4cb92539e2200d139\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"4ce50f6cfcc40e7e6e2902fdeb798d5bd5070268\", \"got_revision_cp\": \"refs/heads/master@{#863111}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"69b79eec6533f113920a5dd863ee2dea7d0c64e7\", \"got_v8_revision\": \"375577d504d1be5ea36a67796334b0a4c6cf320f\", \"got_v8_revision_cp\": \"refs/heads/9.1.128@{#1}\", \"got_webrtc_revision\": \"6097b0fac0946a29d59a9266ea656c39b3fd7336\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33456}\", \"is_cached\": false, \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"swarm_hashes_refs/heads/master(at){#863111}_without_patch\": {\"upload_trace_processor\": \"b65d60ef4341a9f679bc71c5822fc5c1bad6b73e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1bdf55b197d439c94705ddfba40ad846e2fdb8dd164b64a485766434889345a8_v2\", \"builder_1e6a29180cab26dd3348fa54abb67ed061f7a719cdb336cb75143b23c3452e80_v2\", \"builder_44d97c3a86930e13a38e1eaddb8e17f6891cb7883a214371e74f9ddef6b034c5_v2\", \"builder_48ce158d992f85c54a400240cc3d77408bb96a2369de806c235fde7d7ef64068_v2\", \"builder_572c7d4336ecb7e9d9870c0b7d73eb5c4ec9b5267736155cf1f0727554d722db_v2\", \"builder_6b755bbaffc280fb83e7e303317e4888b2acb597c551cb7db892c262f1cf5030_v2\", \"builder_7e7f4ebc5094421a46baff10228f22baf4d4d757ab94366d4bf23e3f4dc4e562_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-3-r2dm\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615861706906096",
"status": "COMPLETED",
"status_changed_ts": "1615863981705689",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/2459",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9018072156672399280",
"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/8852642094456172624/+/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:52518eb42af31610",
"user_agent:luci-scheduler"
],
"updated_ts": "1615863981719239",
"url": "https://ci.chromium.org/b/8852642094456172624",
"utcnow_ts": "1615863982094108"
}
}
[03:06:22.109] Invocation finished in 1h12m39.217578259s with status SUCCEEDED