fastlane: Transporter error "An error occurred while trying to call the requested method validateAssets. (1272)"

New Issue Checklist

Issue Description

Since yesterday, we are not able to upload builds to Testflight (iOS and tvOS) using Pilot. All uploads fail with the “An error occurred while trying to call the requested method validateAssets. (1272)” error. It seems to be something at Apple’s side, but we’ve checked the App Store Connect service status and all is online. We couldn’t find reports of similar errors here and on Apple Developer Forum. Also, we have managed to upload the same build manually using the Transporter App without errors.

Command executed

fastlane pilot upload --verbose --skip_waiting_for_build_processing=true --api_key_path /Users/aquiris/Jenkins/workspace/AppstoreUpload/api_key.json --app_platform=appletvos '--changelog=2.2 Nightly Build

Complete output when running fastlane, including the stack trace and command used
[2021-11-03T17:54:16.536Z] + fastlane pilot upload --verbose --skip_waiting_for_build_processing=true --api_key_path /Users/aquiris/Jenkins/workspace/AppstoreUpload/api_key.json --app_platform=appletvos '--changelog=2.2 Nightly Build
[2021-11-03T17:54:16.536Z] Env: https://dev.wonderboxdev.com
[2021-11-03T17:54:16.536Z] Branch: release/2.2.0
[2021-11-03T17:54:16.536Z] Debug Button: true
[2021-11-03T17:54:16.536Z] Development Content: true
[2021-11-03T17:54:16.536Z] Content Version Override: -1'
[2021-11-03T17:54:17.756Z] [13:54:17]: Get started using a Gemfile for fastlane https://docs.fastlane.tools/getting-started/ios/setup/#use-a-gemfile
[2021-11-03T17:54:18.978Z] INFO [2021-11-03 13:54:18.84]: Creating authorization token for App Store Connect API
[2021-11-03T17:54:18.978Z] DEBUG [2021-11-03 13:54:18.90]: App identifier (***)
[2021-11-03T17:54:23.927Z] INFO [2021-11-03 13:54:23.63]: Ready to upload new build to TestFlight (App: ***y)...
[2021-11-03T17:54:23.927Z] DEBUG [2021-11-03 13:54:23.63]: App Platform (appletvos)
[2021-11-03T17:54:33.101Z] INFO [2021-11-03 13:54:32.97]: Wrote XML data to '/var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp'
[2021-11-03T17:54:33.101Z] INFO [2021-11-03 13:54:32.97]: Going to upload updated app to App Store Connect
[2021-11-03T17:54:33.101Z] INFO [2021-11-03 13:54:32.97]: This might take a few minutes. Please don't interrupt the script.
[2021-11-03T17:54:33.101Z] DEBUG [2021-11-03 13:54:32.97]: xcrun iTMSTransporter -m upload -jwt YourJWT -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000 2>&1
[2021-11-03T17:54:38.108Z] DEBUG [2021-11-03 13:54:37.16]: [Transporter]: INFO: Configuring logging...
[2021-11-03T17:54:38.108Z] DEBUG [2021-11-03 13:54:37.17]: [Transporter]: INFO: Logging level set to eXtreme
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.56]: [Transporter]: DEBUG: SMART-CLIENT: initializing data center locking ops: [authenticateForSession, validateAssets]
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.60]: [Transporter]: DEBUG: SMART-CLIENT: initializing data centers with: [contentdelivery01.itunes.apple.com]
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.60]: [Transporter]: INFO: iTMSTransporter : iTunes Store Transporter [2.2.0]
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.60]: [Transporter]: INFO: OS identifier: Mac OS X 11.4 (x86_64); jvm=14.0.2+12-iTunesOpenJDK-8; jre=14.0.2+12-iTunesOpenJDK-8
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.60]: [Transporter]: INFO: Memory: [JVM] 999M free, 1024M total, 2048M max [System] (Physical) 406M free, 16384M total (Swap) 1376M free, 2048M total
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.61]: [Transporter]: DBG-X: Memory: [JVM] 999M free, 1024M total, 2048M max [System] (Physical) 406M free, 16384M total (Swap) 1376M free, 2048M total
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.61]: [Transporter]: DBG-X: Using operation named: authenticateForSession
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.64]: [Transporter]: DBG-X: Apple's web service operation input parameters:
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.64]: [Transporter]: DBG-X:   parameter Application = iTMSTransporter
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.64]: [Transporter]: DBG-X:   parameter BaseVersion = 2.1.0
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.64]: [Transporter]: DBG-X:   parameter OSIdentifier = Mac OS X 11.4 (x86_64); jvm=14.0.2+12-iTunesOpenJDK-8; jre=14.0.2+12-iTunesOpenJDK-8
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.64]: [Transporter]: DBG-X:   parameter StatisticsClientStartDateTimeZoneISO = 2021-11-03T13:54:40-04:00
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.64]: [Transporter]: DBG-X:   parameter StatisticsPreviousCallDurationInSecs = 0.228724542
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.65]: [Transporter]: DBG-X:   parameter TransporterArguments = -m upload -jwt **hidden value** -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.65]: [Transporter]: DBG-X:   parameter Version = 2.2.0
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.65]: [Transporter]: DBG-X:   parameter iTMSTransporterMode = upload
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.65]: [Transporter]: INFO: id = 20211103135440-698
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.66]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); current data center is null
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.66]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); iterator was null, setting it
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.66]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); setting current data center to: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.67]: [Transporter]: INFO: iTMSTransporter Correlation Key: c7ea23de-2ad0-49ad-ba02-c6095b597cc0-0001
[2021-11-03T17:54:41.222Z] DEBUG [2021-11-03 13:54:40.67]: [Transporter]: DEBUG: SMART-CLIENT: Host HTTP header: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DEBUG: SMART-CLIENT: pinning data center to: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X: Apple's web service operation return value:
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter SharedSecret = **hidden value**
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter MultipartUploadsEnabled = true
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter EnableJWTForAllCalls = false
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter TxHeaders = {jenga=true}
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter ShouldUseFeatures = (null)
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter SessionExpiration = 2021-11-07T17:54:41.249Z
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter SessionId = CP+qDBIQrlou9yeDSXWEOB8WC1gl0w==
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter ShouldUseRESTAPIs = false
[2021-11-03T17:54:41.577Z] DEBUG [2021-11-03 13:54:41.51]: [Transporter]: DBG-X:   parameter StreamingSettings = {LogStreamingEnabled=true, MultipartUploadsEnabled=true, AssetDescriptionStreamingEnabled=false}
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.53]: [Transporter]: INFO: Upload mode selected.
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X: Memory: [JVM] 982M free, 1024M total, 2048M max [System] (Physical) 401M free, 16384M total (Swap) 1376M free, 2048M total
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X: Using operation named: authenticateForTransportDiscovery
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X: Apple's web service operation input parameters:
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X:   parameter Application = iTMSTransporter
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X:   parameter BaseVersion = 2.1.0
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X:   parameter OSIdentifier = Mac OS X 11.4 (x86_64); jvm=14.0.2+12-iTunesOpenJDK-8; jre=14.0.2+12-iTunesOpenJDK-8
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X:   parameter StatisticsClientStartDateTimeZoneISO = 2021-11-03T13:54:41-04:00
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X:   parameter TransporterArguments = -m upload -jwt **hidden value** -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X:   parameter Version = 2.2.0
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DBG-X:   parameter iTMSTransporterMode = upload
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: INFO: id = 20211103135441-628
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); using pinned data center = contentdelivery01.itunes.apple.com
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.55]: [Transporter]: INFO: iTMSTransporter Correlation Key: c7ea23de-2ad0-49ad-ba02-c6095b597cc0-0001
[2021-11-03T17:54:41.931Z] DEBUG [2021-11-03 13:54:41.56]: [Transporter]: DEBUG: SMART-CLIENT: Host HTTP header: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X: Apple's web service operation return value:
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter EnableJWTForAllCalls = false
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter PreferredTransports = [HTTP, Signiant, Aspera, DAV]
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter TransportHosts.Signiant = [sgr602.apple.com:44001, sgr604.apple.com:44001, sgr603.apple.com:44001, sgr601.apple.com:44001]
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter ShouldUseFeatures = (null)
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter SessionExpiration = 2021-11-07T17:54:41.853Z
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter TransportHosts.DAV = [itmsdav.apple.com:443]
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter TransportHosts.Aspera = [vgr504.apple.com:33001, vgr503.apple.com:33001, vgr501.apple.com:33001, vgr502.apple.com:33001]
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter ShouldUseRESTAPIs = false
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.86]: [Transporter]: DBG-X:   parameter StreamingSettings = {LogStreamingEnabled=true, MultipartUploadsEnabled=true, AssetDescriptionStreamingEnabled=false}
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.87]: [Transporter]: INFO: Transporter's command line arguments are: -m upload -jwt **hidden value** -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.88]: [Transporter]: INFO: Gathering the list of valid files from the package ...
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.88]: [Transporter]: DEBUG:   metadata.xml will be verified by Apple's web service to determine if it is a valid file.
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.88]: [Transporter]: DEBUG:   b508e1f0180151fd4770ff707a6836cf2131eaff68df1aaf7104a0228638b96c.ipa will be verified by Apple's web service to determine if it is a valid file.
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.88]: [Transporter]: INFO: Finished gathering the list of valid files from the package.
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.88]: [Transporter]: INFO: Examining the package at: /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.88]: [Transporter]: INFO: Ensuring that package has well formed metadata file...
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.88]: [Transporter]: DEBUG: Getting case-sensitive metadata xml filename...
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.88]: [Transporter]: DEBUG:   Case-sensitive metadata filename is: metadata.xml
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.90]: [Transporter]: INFO: Performing authentication of package 1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp ...
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.92]: [Transporter]: DBG-X: Memory: [JVM] 966M free, 1024M total, 2048M max [System] (Physical) 397M free, 16384M total (Swap) 1376M free, 2048M total
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.92]: [Transporter]: DBG-X: Deflated 492 bytes to 432
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.92]: [Transporter]: DBG-X: Using operation named: validateMetadata
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X: Apple's web service operation input parameters:
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter Application = iTMSTransporter
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter BaseVersion = 2.1.0
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter Files = [metadata.xml, b508e1f0180151fd4770ff707a6836cf2131eaff68df1aaf7104a0228638b96c.ipa]
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter Metadata = <?xml version="1.0" encoding="UTF-8"?>
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter MetadataChecksum = d1eb119b7c0ca00e2cae4987b10c3bfb
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter MetadataCompressed = (suppressed)
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter MetadataInfo = {app_platform=appletvos, primary_bundle_identifier=, device_id=, bundle_identifier=, packageVersion=software5.4, apple_id=1520720139, asset_types=[bundle], bundle_version=, bundle_short_version_string=}
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter OSIdentifier = Mac OS X 11.4 (x86_64); jvm=14.0.2+12-iTunesOpenJDK-8; jre=14.0.2+12-iTunesOpenJDK-8
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter PackageName = 1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter PackageSize = 1665948088
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter StatisticsClientStartDateTimeZoneISO = 2021-11-03T13:54:42-04:00
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter Throttle = 100000
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter TransporterArguments = -m upload -jwt **hidden value** -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter Version = 2.2.0
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DBG-X:   parameter iTMSTransporterMode = upload
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: INFO: id = 20211103135442-482
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); using pinned data center = contentdelivery01.itunes.apple.com
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: INFO: iTMSTransporter Correlation Key: c7ea23de-2ad0-49ad-ba02-c6095b597cc0-0001
[2021-11-03T17:54:43.155Z] DEBUG [2021-11-03 13:54:42.93]: [Transporter]: DEBUG: SMART-CLIENT: Host HTTP header: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X: Apple's web service operation return value:
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter EnableJWTForAllCalls = false
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter ShouldUseFeatures = (null)
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter SessionExpiration = 2021-11-07T17:54:43.042Z
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter MinimumFileSizeThresholdForCheckum = 104857600
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter SoftwareMediaDescriptionFormat = binary
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter SoftwareMediaDescriptionThresholds = {in-app-purchase-content={extensions=[pkg], size=100000000}, ccats={extensions=[pdf], size=100000000}, product-archive={extensions=[pkg], size=100000000}, developer-id-package={extensions=[zip, pkg, dmg], size=100000000}, bundle={extensions=[zip, ipa], size=100000000}, large-icon={extensions=[jpg, png, jpeg], size=100000000}}
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter Success = true
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter StreamingSettings = {LogStreamingEnabled=true, MultipartUploadsEnabled=true, AssetDescriptionStreamingEnabled=false}
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter FilesToUpload = [metadata.xml, b508e1f0180151fd4770ff707a6836cf2131eaff68df1aaf7104a0228638b96c.ipa]
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter AssetsToDescribe = []
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter CPUToken = 0882917a-e089-43e5-b680-457000f9c142/1635962085064
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter Checksums = {b508e1f0180151fd4770ff707a6836cf2131eaff68df1aaf7104a0228638b96c.ipa=d8c15ffd8376fd8ee425b0860690cc57}
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter FileSizes = {b508e1f0180151fd4770ff707a6836cf2131eaff68df1aaf7104a0228638b96c.ipa=1665947596}
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter ShouldUseRESTAPIs = false
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.15]: [Transporter]: DBG-X:   parameter ProviderNameForToken = GS38739929
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.16]: [Transporter]: INFO: The list of files requested for upload by Apple is: [metadata.xml, b508e1f0180151fd4770ff707a6836cf2131eaff68df1aaf7104a0228638b96c.ipa].  These are the files that will be uploaded.
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.16]: [Transporter]: INFO: Nothing to describe for media analysis of assets
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X: Memory: [JVM] 965M free, 1024M total, 2048M max [System] (Physical) 396M free, 16384M total (Swap) 1376M free, 2048M total
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X: Using operation named: lookupTransportDiagnostic
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X: Apple's web service operation input parameters:
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X:   parameter Application = iTMSTransporter
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X:   parameter BaseVersion = 2.1.0
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X:   parameter OSIdentifier = Mac OS X 11.4 (x86_64); jvm=14.0.2+12-iTunesOpenJDK-8; jre=14.0.2+12-iTunesOpenJDK-8
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X:   parameter StatisticsClientStartDateTimeZoneISO = 2021-11-03T13:54:45-04:00
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X:   parameter TransporterArguments = -m upload -jwt **hidden value** -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X:   parameter TxTransportVersions = {SigniantTCP=1.2.0, Aspera=1.2.1, DAV=1.2.0, Signiant=1.2.0, HTTP=1.4.3}
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X:   parameter Version = 2.2.0
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DBG-X:   parameter iTMSTransporterMode = upload
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: INFO: id = 20211103135445-143
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); using pinned data center = contentdelivery01.itunes.apple.com
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: INFO: iTMSTransporter Correlation Key: c7ea23de-2ad0-49ad-ba02-c6095b597cc0-0001
[2021-11-03T17:54:45.535Z] DEBUG [2021-11-03 13:54:45.17]: [Transporter]: DEBUG: SMART-CLIENT: Host HTTP header: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.25]: [Transporter]: DBG-X: Apple's web service operation return value:
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.25]: [Transporter]: DBG-X:   parameter AsperaLoggingLevel = OFF
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.25]: [Transporter]: DBG-X:   parameter EnableJWTForAllCalls = false
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.25]: [Transporter]: DBG-X:   parameter SigniantLoggingLevel = OFF
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.25]: [Transporter]: DBG-X:   parameter ShouldUseFeatures = (null)
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.25]: [Transporter]: DBG-X:   parameter SessionExpiration = 2021-11-07T17:54:45.372Z
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.25]: [Transporter]: DBG-X:   parameter ShouldUseRESTAPIs = false
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.25]: [Transporter]: DBG-X:   parameter StreamingSettings = {LogStreamingEnabled=true, MultipartUploadsEnabled=true, AssetDescriptionStreamingEnabled=false}
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.28]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); using pinned data center = contentdelivery01.itunes.apple.com
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.29]: [Transporter]: DBG-X: Using operation named: createTestReservation
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.29]: [Transporter]: DBG-X: Apple's web service operation input parameters:
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: DBG-X:   parameter Application = iTMSTransporter
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: DBG-X:   parameter BaseVersion = 2.1.0
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: DBG-X:   parameter fileDescriptions = ( one FileDescription )
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: DBG-X:   parameter iTMSTransporterMode = upload
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: DBG-X:   parameter NewPackageName = http-transport-diagnostic-20211103175447-284-1173.itmsp
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: DBG-X:   parameter OSIdentifier = Mac OS X 11.4 (x86_64); jvm=14.0.2+12-iTunesOpenJDK-8; jre=14.0.2+12-iTunesOpenJDK-8
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: DBG-X:   parameter TransporterArguments = -m upload -jwt **hidden value** -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: DBG-X:   parameter Version = 2.2.0
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.30]: [Transporter]: INFO: id = 20211103135447-799
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.41]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); using pinned data center = contentdelivery01.itunes.apple.com
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.41]: [Transporter]: INFO: iTMSTransporter Correlation Key: c7ea23de-2ad0-49ad-ba02-c6095b597cc0-0001
[2021-11-03T17:54:47.918Z] DEBUG [2021-11-03 13:54:47.41]: [Transporter]: DEBUG: DataCenter: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.25]: [Transporter]: DBG-X: Apple's web service operation return value:
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.25]: [Transporter]: DBG-X:   parameter Reservations = ( one Reservation )
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.25]: [Transporter]: DBG-X:   parameter SessionExpiration = 2021-11-07T17:54:48.133Z
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.25]: [Transporter]: DBG-X:   parameter Success = true
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.26]: [Transporter]: INFO: Setting transport log file: /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/http-transport-diagnostic-20211103175447-284-1173.itmsp18408035863351330162.log
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.26]: [Transporter]: INFO: Starting upload for packageName: http-transport-diagnostic-20211103175447-284-1173.itmsp
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.26]: [Transporter]: INFO: Thread Pool Configuration: {rateLimit=100000 KBs, minConnections=6, coreThreads=6, perCoreThreadMultiplier=1.65, processors=8, maxThreads=14, maxConnections=13}
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.27]: [Transporter]: INFO: Reservation CPUSource115/v4/ed/36/bd/ed36bd05-c78a-d153-d1dd-0524ed0229dd/http-transport-diagnostic-7462376796017457308.txt created for file: (http-transport-diagnostic-7462376796017457308.txt), part count:(1), file size: (199)
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.27]: [Transporter]: INFO: Computing total size of files to upload ...
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.28]: [Transporter]: DBG-X:   adding file for % complete logging: http-transport-diagnostic-7462376796017457308.txt , size: 199
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.28]: [Transporter]: DEBUG: Setting total size of files for upload to: 199
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.28]: [Transporter]: INFO: Done computing total size of files to upload.
[2021-11-03T17:54:48.680Z] DEBUG [2021-11-03 13:54:48.29]: [Transporter]: INFO: Starting upload for reservation: (CPUSource115/v4/ed/36/bd/ed36bd05-c78a-d153-d1dd-0524ed0229dd/http-transport-diagnostic-7462376796017457308.txt) file: (http-transport-diagnostic-7462376796017457308.txt/1) size: 199
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.80]: [Transporter]: INFO:      File: http-transport-diagnostic-7462376796017457308.txt 199/199, 100.00% completed
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.81]: [Transporter]: INFO: Package upload progress: 100.00% completed
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.95]: [Transporter]: INFO: Finished part upload for: (http-transport-diagnostic-7462376796017457308.txt/1) 1.25 KB/s in 0 seconds
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.95]: [Transporter]: INFO: Finished upload for reservation: (CPUSource115/v4/ed/36/bd/ed36bd05-c78a-d153-d1dd-0524ed0229dd/http-transport-diagnostic-7462376796017457308.txt) file: (http-transport-diagnostic-7462376796017457308.txt)
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); using pinned data center = contentdelivery01.itunes.apple.com
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: INFO: Waiting on reservation commit(s) to finish.
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X: Using operation named: commitTestReservation
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X: Apple's web service operation input parameters:
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X:   parameter Application = iTMSTransporter
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X:   parameter BaseVersion = 2.1.0
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X:   parameter iTMSTransporterMode = upload
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X:   parameter NewPackageName = http-transport-diagnostic-20211103175447-284-1173.itmsp
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X:   parameter OSIdentifier = Mac OS X 11.4 (x86_64); jvm=14.0.2+12-iTunesOpenJDK-8; jre=14.0.2+12-iTunesOpenJDK-8
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X:   parameter reservations = [CPUSource115/v4/ed/36/bd/ed36bd05-c78a-d153-d1dd-0524ed0229dd/http-transport-diagnostic-7462376796017457308.txt]
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X:   parameter TransporterArguments = -m upload -jwt **hidden value** -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: DBG-X:   parameter Version = 2.2.0
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.96]: [Transporter]: INFO: id = 20211103135448-630
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.98]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); using pinned data center = contentdelivery01.itunes.apple.com
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.98]: [Transporter]: INFO: iTMSTransporter Correlation Key: c7ea23de-2ad0-49ad-ba02-c6095b597cc0-0001
[2021-11-03T17:54:49.037Z] DEBUG [2021-11-03 13:54:48.98]: [Transporter]: DEBUG: DataCenter: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.40]: [Transporter]: DBG-X: Apple's web service operation return value:
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.40]: [Transporter]: DBG-X:   parameter SessionExpiration = 2021-11-07T17:54:49.077Z
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.40]: [Transporter]: DBG-X:   parameter Success = true
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.40]: [Transporter]: INFO: Reservation committed: (CPUSource115/v4/ed/36/bd/ed36bd05-c78a-d153-d1dd-0524ed0229dd/http-transport-diagnostic-7462376796017457308.txt) file: (http-transport-diagnostic-7462376796017457308.txt)
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.40]: [Transporter]: INFO: All reservation commit(s) finished.
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.41]: [Transporter]: INFO: 175.80 B/s in 1 second
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DEBUG: Using token file path /Users/aquiris/Library/Caches/com.apple.amp.itmstransporter/UploadTokens/administrators-Mac-mini.local_GS38739929_1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp.token
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DEBUG: Attempting exclusive file lock on token file
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DEBUG: Set token: 0882917a-e089-43e5-b680-457000f9c142/1635962085064
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X: Memory: [JVM] 944M free, 1024M total, 2048M max [System] (Physical) 388M free, 16384M total (Swap) 1376M free, 2048M total
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X: Deflated 492 bytes to 432
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X: Using operation named: validateAssets
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X: Apple's web service operation input parameters:
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter Application = iTMSTransporter
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter BaseVersion = 2.1.0
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter CPUToken = 0882917a-e089-43e5-b680-457000f9c142/1635962085064
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter Files = [metadata.xml, b508e1f0180151fd4770ff707a6836cf2131eaff68df1aaf7104a0228638b96c.ipa]
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter MetadataChecksum = d1eb119b7c0ca00e2cae4987b10c3bfb
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter MetadataCompressed = (suppressed)
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter MetadataInfo = {app_platform=appletvos, primary_bundle_identifier=, device_id=, bundle_identifier=, packageVersion=software5.4, apple_id=1520720139, asset_types=[bundle], bundle_version=, bundle_short_version_string=}
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter OSIdentifier = Mac OS X 11.4 (x86_64); jvm=14.0.2+12-iTunesOpenJDK-8; jre=14.0.2+12-iTunesOpenJDK-8
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter PackageName = 1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter PackageSize = 1665948088
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter RequestUUID = c2bc559d-af08-4b6b-be85-09e00bd1f3ce
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter StatisticsClientStartDateTimeZoneISO = 2021-11-03T13:54:49-04:00
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.44]: [Transporter]: DBG-X:   parameter Throttle = 100000
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: DBG-X:   parameter Transport = HTTP
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: DBG-X:   parameter TransporterArguments = -m upload -jwt **hidden value** -f /var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp -k 100000
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: DBG-X:   parameter TxTransportVersions = {SigniantTCP=1.2.0, Aspera=1.2.1, DAV=1.2.0, Signiant=1.2.0, HTTP=1.4.3}
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: DBG-X:   parameter Version = 2.2.0
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: DBG-X:   parameter iTMSTransporterMode = upload
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: INFO: id = 20211103135449-450
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: DEBUG: SMART-CLIENT: getCurrent(); using pinned data center = contentdelivery01.itunes.apple.com
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: INFO: iTMSTransporter Correlation Key: c7ea23de-2ad0-49ad-ba02-c6095b597cc0-0001
[2021-11-03T17:54:49.796Z] DEBUG [2021-11-03 13:54:49.45]: [Transporter]: DEBUG: SMART-CLIENT: Host HTTP header: contentdelivery01.itunes.apple.com
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X: Apple's web service operation return value:
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X:   parameter Errors = [An error occurred while trying to call the requested method validateAssets. (1272)]
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X:   parameter EnableJWTForAllCalls = false
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X:   parameter ShouldUseFeatures = (null)
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X:   parameter RestartClient = false
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X:   parameter ErrorCode = 1272
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X:   parameter ErrorMessage = An error occurred while trying to call the requested method validateAssets. (1272)
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X:   parameter ShouldUseRESTAPIs = false
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X:   parameter Success = false
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: DBG-X: The error code is: 1272
[2021-11-03T17:54:52.910Z] DEBUG [2021-11-03 13:54:52.76]: [Transporter]: INFO: Done performing authentication.
[2021-11-03T17:54:53.268Z] ERROR [2021-11-03 13:54:52.87]: Transporter transfer failed.
[2021-11-03T17:54:53.268Z] WARN [2021-11-03 13:54:52.87]: 
[2021-11-03T17:54:53.268Z] ERROR [2021-11-03 13:54:52.87]: An error occurred while trying to call the requested method validateAssets. (1272)

[2021-11-03T17:54:53.625Z] WARN [2021-11-03 13:54:53.23]: [iTMSTransporter] [2021-11-03 13:54:52 EDT] <main> DBG-X:   parameter ErrorMessage = An error occurred while trying to call the requested method validateAssets. (1272)
[2021-11-03T17:54:53.625Z] 
[2021-11-03T17:54:53.625Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] [2021-11-03 13:54:52 EDT] <main> DBG-X:   parameter ShouldUseRESTAPIs = false
[2021-11-03T17:54:53.625Z] 
[2021-11-03T17:54:53.625Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] [2021-11-03 13:54:52 EDT] <main> DBG-X:   parameter Success = false
[2021-11-03T17:54:53.625Z] 
[2021-11-03T17:54:53.625Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] [2021-11-03 13:54:52 EDT] <main> ERROR: An error occurred while trying to call the requested method validateAssets. (1272)
[2021-11-03T17:54:53.625Z] 
[2021-11-03T17:54:53.625Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] [2021-11-03 13:54:52 EDT] <main> DBG-X: The error code is: 1272
[2021-11-03T17:54:53.625Z] 
[2021-11-03T17:54:53.625Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] [2021-11-03 13:54:52 EDT] <main>  INFO: Done performing authentication.
[2021-11-03T17:54:53.625Z] 
[2021-11-03T17:54:53.625Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] 
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] 
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] 
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] Package Summary:
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter]  
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] 1 package(s) were not uploaded because they had problems:
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] 	/var/folders/ym/dgt7pnss2rvblfnggshs_q480000gp/T/d20211103-56747-osueyi/1520720139-6a162c39-f397-454e-8bca-48c15aac2845.itmsp - Error Messages:
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] 		An error occurred while trying to call the requested method validateAssets. (1272)
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] WARN [2021-11-03 13:54:53.24]: [iTMSTransporter] [2021-11-03 13:54:52 EDT] <main> DBG-X: Returning 1
[2021-11-03T17:54:53.626Z] 
[2021-11-03T17:54:53.626Z] INFO [2021-11-03 13:54:53.24]: iTunes Transporter output above ^
[2021-11-03T17:54:53.626Z] ERROR [2021-11-03 13:54:53.24]: An error occurred while trying to call the requested method validateAssets. (1272)
[2021-11-03T17:54:53.626Z] Return status of iTunes Transporter was 1: An error occurred while trying to call the requested method validateAssets. (1272)
[2021-11-03T17:54:53.626Z] The call to the iTMSTransporter completed with a non-zero exit status: 1. This indicates a failure.
[2021-11-03T17:54:53.626Z] /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/fastlane_core/lib/fastlane_core/ui/interface.rb:141:in `user_error!': [!] Error uploading ipa file:  (FastlaneCore::Interface::FastlaneError)
[2021-11-03T17:54:53.626Z]  
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/fastlane_core/lib/fastlane_core/ui/ui.rb:17:in `method_missing'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/pilot/lib/pilot/build_manager.rb:45:in `upload'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/pilot/lib/pilot/commands_generator.rb:67:in `block (2 levels) in run'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/commander-4.6.0/lib/commander/command.rb:187:in `call'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/commander-4.6.0/lib/commander/command.rb:157:in `run'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/commander-4.6.0/lib/commander/runner.rb:444:in `run_active_command'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/fastlane_core/lib/fastlane_core/ui/fastlane_runner.rb:117:in `run!'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/commander-4.6.0/lib/commander/delegates.rb:18:in `run!'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/pilot/lib/pilot/commands_generator.rb:167:in `run'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/pilot/lib/pilot/commands_generator.rb:19:in `start'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/fastlane/lib/fastlane/cli_tools_distributor.rb:114:in `take_off'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/bin/fastlane:23:in `<top (required)>'
[2021-11-03T17:54:53.626Z] 	from /usr/local/bin/fastlane:23:in `load'
[2021-11-03T17:54:53.626Z] 	from /usr/local/bin/fastlane:23:in `<main>'
[2021-11-03T17:54:53.626Z] /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/fastlane_core/lib/fastlane_core/ui/interface.rb:141:in `user_error!': Error uploading ipa file:  (FastlaneCore::Interface::FastlaneError)
[2021-11-03T17:54:53.626Z]  
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/fastlane_core/lib/fastlane_core/ui/ui.rb:17:in `method_missing'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/pilot/lib/pilot/build_manager.rb:45:in `upload'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/pilot/lib/pilot/commands_generator.rb:67:in `block (2 levels) in run'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/commander-4.6.0/lib/commander/command.rb:187:in `call'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/commander-4.6.0/lib/commander/command.rb:157:in `run'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/commander-4.6.0/lib/commander/runner.rb:444:in `run_active_command'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/fastlane_core/lib/fastlane_core/ui/fastlane_runner.rb:117:in `run!'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/commander-4.6.0/lib/commander/delegates.rb:18:in `run!'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/pilot/lib/pilot/commands_generator.rb:167:in `run'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/pilot/lib/pilot/commands_generator.rb:19:in `start'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/fastlane/lib/fastlane/cli_tools_distributor.rb:114:in `take_off'
[2021-11-03T17:54:53.626Z] 	from /Library/Ruby/Gems/2.6.0/gems/fastlane-2.197.0/bin/fastlane:23:in `<top (required)>'
[2021-11-03T17:54:53.626Z] 	from /usr/local/bin/fastlane:23:in `load'
[2021-11-03T17:54:53.626Z] 	from /usr/local/bin/fastlane:23:in `<main>'

Environment

[✔] 🚀 
[14:26:37]: Get started using a Gemfile for fastlane https://docs.fastlane.tools/getting-started/ios/setup/#use-a-gemfile
[14:26:38]: Generating fastlane environment output, this might take a few seconds...
swift-driver version: 1.26.9 
✅ fastlane environment ✅

Stack

Key Value
OS 11.4
Ruby 2.6.3
Bundler? false
Git git version 2.30.1 (Apple Git-130)
Installation Source /usr/local/bin/fastlane
Host macOS 11.4 (20F71)
Ruby Lib Dir /System/Library/Frameworks/Ruby.framework/Versions/2.6/usr/lib
OpenSSL Version LibreSSL 2.8.3
Is contained false
Is homebrew false
Is installed via Fabric.app false
Xcode Path /Applications/Xcode-13.app/Contents/Developer/
Xcode Version 13.0
Swift Version 5.5

System Locale

Variable Value
LANG en_US.UTF-8
LC_ALL en_US.UTF-8
LANGUAGE

fastlane files:

No Fastfile found

No Appfile found

fastlane gems

Gem Version Update-Status
fastlane 2.197.0 ✅ Up-To-Date

Loaded fastlane plugins:

No plugins Loaded

Loaded gems
Gem Version
did_you_mean 1.3.0
atomos 0.1.3
CFPropertyList 2.3.6
claide 1.0.3
colored2 3.1.2
nanaimo 0.3.0
rexml 3.2.5
xcodeproj 1.21.0
rouge 2.0.7
xcpretty 0.3.0
terminal-notifier 2.0.0
unicode-display_width 1.8.0
terminal-table 1.8.0
plist 3.6.0
public_suffix 4.0.6
addressable 2.8.0
multipart-post 2.0.0
word_wrap 1.0.0
optparse 0.1.1
tty-screen 0.8.1
tty-cursor 0.7.1
tty-spinner 0.9.3
artifactory 3.0.15
babosa 1.0.4
colored 1.2
highline 2.0.3
commander 4.6.0
excon 0.85.0
faraday-em_http 1.0.0
faraday-em_synchrony 1.0.0
faraday-excon 1.1.0
faraday-httpclient 1.0.1
faraday-net_http 1.0.1
faraday-net_http_persistent 1.2.0
faraday-patron 1.0.0
faraday-rack 1.0.0
ruby2_keywords 0.0.5
faraday 1.8.0
unf_ext 0.0.8
unf 0.1.4
domain_name 0.5.20190701
http-cookie 1.0.4
faraday-cookie_jar 0.0.7
faraday_middleware 1.1.0
fastimage 2.2.5
gh_inspector 1.1.3
json 2.1.0
mini_magick 4.11.0
naturally 2.2.1
rubyzip 2.3.2
security 0.1.3
xcpretty-travis-formatter 1.0.1
dotenv 2.7.6
bundler 1.17.2
simctl 1.6.8
jwt 2.2.3
uber 0.1.0
declarative 0.0.20
trailblazer-option 0.1.1
representable 3.1.1
retriable 3.1.2
mini_mime 1.1.1
memoist 0.16.2
multi_json 1.15.0
os 1.1.1
signet 0.16.0
googleauth 0.17.1
httpclient 2.8.3
webrick 1.4.2
google-apis-core 0.4.1
google-apis-playcustomapp_v1 0.5.0
google-apis-androidpublisher_v3 0.11.0
google-cloud-env 1.5.0
google-cloud-errors 1.2.0
google-cloud-core 1.6.0
google-apis-iamcredentials_v1 0.7.0
google-apis-storage_v1 0.7.0
rake 12.3.2
digest-crc 0.6.4
google-cloud-storage 1.34.1
emoji_regex 3.2.2
jmespath 1.4.0
aws-partitions 1.504.0
aws-eventstream 1.2.0
aws-sigv4 1.4.0
aws-sdk-core 3.121.0
aws-sdk-kms 1.48.0
aws-sdk-s3 1.103.0
forwardable 1.2.0
logger 1.3.0
date 2.0.0
stringio 0.0.2
ipaddr 1.2.2
openssl 2.1.2
zlib 1.0.0
mutex_m 0.1.0
ostruct 0.1.0
strscan 1.0.0
io-console 0.4.7
fileutils 1.1.0
etc 1.0.1
libxml-ruby 3.1.0
psych 3.1.0

generated on: 2021-11-03

About this issue

  • Original URL
  • State: closed
  • Created 3 years ago
  • Reactions: 15
  • Comments: 36 (8 by maintainers)

Most upvoted comments

Hey everyone! 👋 I’m taking a look at this one today!

@taylorfort looks like a great fix so I’m starting with that 🙌 This is kind of a delicate change because the -f parameter takes an .itmsp file where the change to -assetFile takes a .ipa/.dmg/.pkg. This change kind of makes things easier because one less thing to generate but -assetFile behaves differently on macOS than Linux and Windows. If running on Linux and Windows (which some users do), it looks like we also need to add a -assetDescription which is a reference to some plist file 🤷‍♂️

I’ll be adding a few commits onto the PR that @taylorfort made to make sure this stays backwards compatible and working for all users but this fix should hopefully go out later today 🤞

So I have a solution that is working for me. Needs to be improved. but it’s working until something better comes along.

I’ve left my Fastfile as it was, so still calling upload_to_testflight the same way, and changed 2 lines in fastlane. I’m on 2.197.0, so your line numbers might change, and please note, this will disappear when you next update fastlane.

My fastlane on my Mac was in the parent folder of my source project under: vendor/bundle/ruby/2.7.0/gems/fastlane-2.197.0/

I changed

  • line 36 of fastlane_core/lib/fastlane_core/ipa_upload_package_builder.rb From: return self.package_path To: return ipa_path

And

  • line 264 of fastlane_core/lib/fastlane_core/itunes_transporter.rb From: "-f #{source.shellescape}", To: "-assetFile #{source.shellescape}",

Hope this helps somebody. I might try to make it a proper switch and make a PR if I get time, but this has got us back working.

Still down for us too. We are manually uploading our builds using the Transporter app for Mac.

We are having similar issues running 2.171.0. Issue just showed up last night

FWIW, having this issue not using fastlane and not using ODRs.

Just to throw a spanner in your size related error theory, the IPAs for which I am getting this error are 51MB and 240MB. That said, I’m not using fastlane - I just had this exact problem start at the exact same time this was posted and this just seems to be the only place where this problem is being discussed so am working on the assumption that it’s the same issue.

I’ve done some testing today, and I’ve been running Transporter directly from the CLI.

What I found is that fastlane is running this command (but with a -jwt instead of -apiKey):

/Applications/Transporter.app/Contents/itms/bin/iTMSTransporter -m upload -f /var/folders/m7/8ktd1mk93dldrjzl4w9381s80000gp/T/d20211110-38050-182cs6m/1200357146-35de8baa-1916-47b1-9cca-4f699a959ccd.itmsp -apiKey xxxxxxxxxx -apiIssuer xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxx

pointing to the itmsp folder, which fails with the validateAssets error.

Whereas when I point to the built .ipa directly using:

/Applications/Transporter.app/Contents/itms/bin/iTMSTransporter -m upload -assetFile /var/folders/m7/8ktd1mk93dldrjzl4w9381s80000gp/T/d20211110-38050-182cs6m/1200357146-35de8baa-1916-47b1-9cca-4f699a959ccd.itmsp/55f14ff2cbaffe02bfafa7a697f243050f174cfa408c2b45afe2abdbbd1b47ea.ipa-apiKey xxxxxxxxxx -apiIssuer xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxx

it uploads just fine.

Also, I’m not sure if this is related but the fastlane metadata.xml looks like this:

<?xml version="1.0" encoding="UTF-8"?>
<package xmlns="http://apple.com/itunes/importer" version="software5.4">
  <software_assets apple_id="*************" app_platform="ios">
    <asset type="bundle">
      <data_file>
        <size>1420655992</size>
        <file_name>55f14ff2cbaffe02bfafa7a697f243050f174cfa408c2b45afe2abdbbd1b47ea.ipa</file_name>
        <checksum type="md5">004f760af1104130e18e22</checksum>
      </data_file>
    </asset>
  </software_assets>
</package>

whereas that generated by using just the .ipa looks like:

<?xml version="1.0" encoding="UTF-8"?>
<package version="software5.4" xmlns="http://apple.com/itunes/importer">
    <software_assets apple_id="*********"
        bundle_short_version_string="2.8.0"
        bundle_version="799"
        bundle_identifier="**********.*********"
        app_platform="ios">
        <asset type="bundle">
            <data_file>
                <file_name>55f14ff2cbaffe02bfafa7a697f243050f174cfa408c2b45afe2abdbbd1b47ea.ipa</file_name>
                <checksum type="md5">004f760af1104130e18e22</checksum>
                <size>1420655992</size>
            </data_file>
        </asset>
    </software_assets>
</package>

I’m having the same problem, I believe it may be a specific configuration, I have some application with a certain configuration and others with others. I always send it to Apple, 3 of them work, one of them doesn’t go for nothing.

Always returning the same error

Same issue since yesterday. But not for all apps. We’re using on-demand resources (ODR) for some of our projects and this issue appears only for them. Was able to make it pass by reducing ODR size to be less than 1gb. But this is not a solution. Assume that it might an issue on AppStore side.

Update: I added some commits to the #19596 if anybody wants to take a look and/or test it out 😊 Took a little bit longer than I thought to test it all out but had to make super sure I didn’t break things 😛