[Info: 2022-05-01 11:52:39.356597955: NetQueue.cpp(186)] NetQueue: Setting up. [Info: 2022-05-01 11:52:39.357033220: NetQueue.cpp(622)] NetQueue: worker thread started. [Info: 2022-05-01 11:52:39.357151943: mainLinux.cpp(258)] Running launcher bootstrap (version 1.1.11) [Info: 2022-05-01 11:52:39.366536562: Common.cpp(32)] Native Launcher Version: 1.1.11 [Info: 2022-05-01 11:52:39.366566855: Common.cpp(33)] Operating System: Linux [Info: 2022-05-01 11:52:39.366583954: Common.cpp(34)] Application Data directory: /.../.minecraft [Info: 2022-05-01 11:52:39.366614866: Common.cpp(35)] Executable Path: /.../minecraft-launcher [Info: 2022-05-01 11:52:39.366633984: Common.cpp(36)] App Directory dir: /.../launcher [Info: 2022-05-01 11:52:39.366651072: Common.cpp(37)] Game data directory: /.../.minecraft [Info: 2022-05-01 11:52:39.366668869: Common.cpp(38)] Launcher dir: /.../launcher [Info: 2022-05-01 11:52:39.366692148: Common.cpp(39)] Java dir: /.../jre-x64 [Info: 2022-05-01 11:52:39.366708442: Common.cpp(40)] TmpDir dir: /.../MinecraftLauncher.1000 [Info: 2022-05-01 11:52:39.366722947: Common.cpp(41)] x64: true [Info: 2022-05-01 11:52:39.367192876: mainLinux.cpp(339)] resolvedExe: /.../minecraft-launcher selfExe: /.../minecraft-launcher [Info: 2022-05-01 11:52:39.367223192: mainLinux.cpp(353)] Chain-loaded executable, watching parent for termination. [Info: 2022-05-01 11:52:39.367285142: Common.cpp(32)] Native Launcher Version: 1.1.11 [Info: 2022-05-01 11:52:39.367308773: Common.cpp(33)] Operating System: Linux [Info: 2022-05-01 11:52:39.367324855: Common.cpp(34)] Application Data directory: /.../.minecraft [Info: 2022-05-01 11:52:39.367347885: Common.cpp(35)] Executable Path: /.../minecraft-launcher [Info: 2022-05-01 11:52:39.367368057: Common.cpp(36)] App Directory dir: /.../launcher [Info: 2022-05-01 11:52:39.367395406: Common.cpp(37)] Game data directory: /.../.minecraft [Info: 2022-05-01 11:52:39.367413670: Common.cpp(38)] Launcher dir: /.../launcher [Info: 2022-05-01 11:52:39.367431329: Common.cpp(39)] Java dir: /.../jre-x64 [Info: 2022-05-01 11:52:39.367449010: Common.cpp(40)] TmpDir dir: /.../MinecraftLauncher.1000 [Info: 2022-05-01 11:52:39.367469524: Common.cpp(41)] x64: true [Info: 2022-05-01 11:52:39.377366348: NetQueue.cpp(186)] NetQueue: Setting up. [Info: 2022-05-01 11:52:39.377581422: NetQueue.cpp(622)] NetQueue: worker thread started. [Info: 2022-05-01 11:52:39.377589393: LauncherConfiguration.cpp(292)] Using update preferences at path: /.../launcher_profiles.json [Warning: 2022-05-01 11:52:39.377730449: LauncherConfiguration.cpp(113)] Failed to get clientToken from configuration, launcher updater will fall back to using stable versions instead of controlled experiment versions. [Info: 2022-05-01 11:52:39.377766425: LauncherConfiguration.cpp(295)] Failed to read update preferences from /.../launcher_profiles.json [Info: 2022-05-01 11:52:39.377796483: LauncherConfiguration.cpp(306)] Using update preferences at path: /.../launcher_settings.json [Info: 2022-05-01 11:52:39.378097029: NetQueue.cpp(632)] NetQueue: Starting net action https://launchermeta.mojang.com/v1/products/launcher/6f083b80d5e6fabbc4236f81d0d8f8a350c665a9/linux.json [Info: 2022-05-01 11:52:39.888916426: NetQueue.cpp(472)] NetQueue: Primary ip: 13.33.242.20, Host: launchermeta.mojang.com [Info: 2022-05-01 11:52:39.889065027: NetQueue.cpp(551)] NetQueue: Action finished: https://launchermeta.mojang.com/v1/products/launcher/6f083b80d5e6fabbc4236f81d0d8f8a350c665a9/linux.json [Info: 2022-05-01 11:52:39.889187025: NetQueue.cpp(579)] NetQueue: Action finalized: https://launchermeta.mojang.com/v1/products/launcher/6f083b80d5e6fabbc4236f81d0d8f8a350c665a9/linux.json [Info: 2022-05-01 11:52:39.944530700: LauncherConfiguration.cpp(198)] Deciding on update with strategy 2 and clientID 1299690807 [Info: 2022-05-01 11:52:39.944783061: LauncherConfiguration.cpp(215)] Version of launcher-bootstrap-ado is current, no action is necessary. [Info: 2022-05-01 11:52:39.944897327: LauncherConfiguration.cpp(248)] Bootstrap is current [Info: 2022-05-01 11:52:39.992399957: LauncherConfiguration.cpp(198)] Deciding on update with strategy 2 and clientID 1299690807 [Info: 2022-05-01 11:52:39.992476599: LauncherConfiguration.cpp(215)] Version of launcher-core-ado is current, no action is necessary. [Info: 2022-05-01 11:52:39.992516483: LauncherConfiguration.cpp(248)] Bootstrap is current [Info: 2022-05-01 11:52:39.992543995: NetQueue.cpp(212)] NetQueue: Initiating shutdown. [Info: 2022-05-01 11:52:39.992561542: NetQueue.cpp(226)] NetQueue: Waiting for worker thread to finish... [Info: 2022-05-01 11:52:39.992582352: NetQueue.cpp(742)] NetQueue: Worker thread shutting down. [Info: 2022-05-01 11:52:39.994420782: NetQueue.cpp(229)] NetQueue: Done. [Info: 2022-05-01 11:52:39.994500840: StartLibrary.cpp(61)] Starting /.../liblauncher.so [Info: 2022-05-01 11:52:41.348561464: StartLibrary.cpp(95)] Running launcher! [Info: 2022-05-01 11:52:41.348721142: StartLibrary.cpp(97)] Logging is open, passing it to Launcher Core. [Info: 2022-05-01 11:52:41.355029667: LauncherMain.cpp(107)] Initiated models [Info: 2022-05-01 11:52:41.512121741: LauncherMain.cpp(290)] Initiated app arguments [Info: 2022-05-01 11:52:41.512401576: LauncherMain.cpp(351)] Initiated directories [Info: 2022-05-01 11:52:41.512590774: LauncherMain.cpp(372)] Initialized network [Info: 2022-05-01 11:52:41.512647193: NetQueue.cpp(186)] NetQueue: Setting up. [Info: 2022-05-01 11:52:41.513100420: NetQueue.cpp(622)] NetQueue: worker thread started. [Info: 2022-05-01 11:52:41.513440470: LauncherMain.cpp(393)] Initialized Sentry [Info: 2022-05-01 11:52:41.513598614: LauncherMain.cpp(399)] workDir: $HOME/.minecraft [Info: 2022-05-01 11:52:41.513696630: LauncherMain.cpp(407)] appDir: $HOME/.minecraft/launcher [Info: 2022-05-01 11:52:41.514352192: LauncherMain.cpp(433)] Launcher core version: 2.3.136 (00984f1bcf82870ece00ad8569b6fe3f5f04d421) [Info: 2022-05-01 11:52:41.514429434: LauncherMain.cpp(434)] Main process: true [Info: 2022-05-01 11:52:41.514491836: NetQueue.cpp(186)] NetQueue: Setting up. [Info: 2022-05-01 11:52:41.514914777: NetQueue.cpp(622)] NetQueue: worker thread started. [Info: 2022-05-01 11:52:41.527758688: NetQueue.cpp(632)] NetQueue: Starting net action https://www.xboxab.com/ab [Info: 2022-05-01 11:52:41.536295201: LauncherController.cpp(468)] Constructing launcher controller with workDir: $HOME/.minecraft, isActive: 1 [Info: 2022-05-01 11:52:41.537828767: SecureTokenStorage_Linux.cpp(32)] Initing linux secure storage [Info: 2022-05-01 11:52:41.539245264: NetQueue.cpp(186)] NetQueue: Setting up. [Info: 2022-05-01 11:52:41.539839077: NetQueue.cpp(622)] NetQueue: worker thread started. [Info: 2022-05-01 11:52:41.540272776: XalStorage.cpp(438)] Parsing content from MSA File [Info: 2022-05-01 11:52:41.540558759: XalContext.cpp(428)] ClockSkew is -2709713 (0 seconds) [Info: 2022-05-01 11:52:41.562264589: Xal.lib(0)] XAL: Initializing Xal 2021.04.20210518.001, generic platform [Info: 2022-05-01 11:52:41.562450423: Xal.lib(0)] XAL: Init args: [Info: 2022-05-01 11:52:41.562657256: Xal.lib(0)] XAL: sandbox: [Info: 2022-05-01 11:52:41.562754889: Xal.lib(0)] XAL: disableDiagnosticTelemetry: false [Info: 2022-05-01 11:52:41.562841615: Xal.lib(0)] XAL: correlationVector: (null) [Info: 2022-05-01 11:52:41.562957886: Xal.lib(0)] XAL: flags: 81000000 [Info: 2022-05-01 11:52:41.563042689: Xal.lib(0)] XAL: maxSignedInUsers: 1 [Info: 2022-05-01 11:52:41.563131650: Xal.lib(0)] XAL: thirdPartyConsent (0) [Info: 2022-05-01 11:52:41.563215157: Xal.lib(0)] XAL: redirectUri: [Info: 2022-05-01 11:52:41.563295440: Xal.lib(0)] XAL: useRemoteAuth: false [Info: 2022-05-01 11:52:41.563367949: Xal.lib(0)] XAL: Device info: [Info: 2022-05-01 11:52:41.563444546: Xal.lib(0)] XAL: deviceType: Win32 [Info: 2022-05-01 11:52:41.563524366: Xal.lib(0)] XAL: osVersion: 6.1.7601 [Info: 2022-05-01 11:52:41.563609159: Xal.lib(0)] XAL: Telemetry info: [Info: 2022-05-01 11:52:41.563689533: Xal.lib(0)] XAL: appId: Minecraft Launcher [Info: 2022-05-01 11:52:41.563765620: Xal.lib(0)] XAL: appVer: 2.3.136 [Info: 2022-05-01 11:52:41.563843326: Xal.lib(0)] XAL: osName: Windows [Info: 2022-05-01 11:52:41.563969021: Xal.lib(0)] XAL: osVersion: 6.1.7601 [Info: 2022-05-01 11:52:41.564055786: Xal.lib(0)] XAL: osLocale: en-US [Info: 2022-05-01 11:52:41.564133152: Xal.lib(0)] XAL: deviceClass: Windows.Desktop [Info: 2022-05-01 11:52:41.569011918: Xal.lib(0)] XAL: Diagnostic telemetry disabled: false [Info: 2022-05-01 11:52:41.579320151: Xal.lib(0)] XAL: [op 93929476551824] Operation UploadTelemetryEventsWithDelay is starting [Info: 2022-05-01 11:52:41.579457161: Xal.lib(0)] XAL_TELEMETRY: AppActivation Version="2021.04.20210518.001" [Error: 2022-05-01 11:52:41.580811532: PersistentReflectedStruct.h(44)] Data version 3 is greater than current version 0 but we don't support downgrading. [Warning: 2022-05-01 11:52:41.580911556: PreferencesManager.cpp(567)] Unable to load profile settings. [Info: 2022-05-01 11:52:41.581363607: PreferencesManager.cpp(116)] Removed $HOME/.minecraft/launcher_profiles_microsoft_store.json [Warning: 2022-05-01 11:52:41.859890223: XalApi.cpp(192)] Failed to register user callback: -2147024846 [Info: 2022-05-01 11:52:41.894723646: GameVersionManager.cpp(267)] Reading local cache of the Mojang versions manifest... [Info: 2022-05-01 11:52:41.917986848: GameVersionManager.cpp(307)] Looking for installed versions in $HOME/.minecraft/versions [Info: 2022-05-01 11:52:41.938844128: GameVersionManager.cpp(348)] Parsing version fabric-loader-0.14.1-1.18.1 [Info: 2022-05-01 11:52:41.968182297: GameVersionManager.cpp(348)] Parsing version 22w16b [Info: 2022-05-01 11:52:42.004392163: GameVersionManager.cpp(348)] Parsing version 22w17a [Info: 2022-05-01 11:52:42.023943014: GameVersionManager.cpp(348)] Parsing version 1.18.1 [Info: 2022-05-01 11:52:42.049164480: GameVersionManager.cpp(348)] Parsing version 1.18.2 [Info: 2022-05-01 11:52:42.113422735: NetQueue.cpp(632)] NetQueue: Starting net action https://launchermeta.mojang.com/mc/game/version_manifest_v2.json?_t=2022-05-01T11:52:42Z [Info: 2022-05-01 11:52:42.115031898: NetQueue.cpp(472)] NetQueue: Primary ip: 13.107.5.91, Host: www.xboxab.com [Info: 2022-05-01 11:52:42.115121879: NetQueue.cpp(551)] NetQueue: Action finished: https://www.xboxab.com/ab [Info: 2022-05-01 11:52:42.115177850: NetQueue.cpp(579)] NetQueue: Action finalized: https://www.xboxab.com/ab [Info: 2022-05-01 11:52:43.047406657: NetQueue.cpp(472)] NetQueue: Primary ip: 13.35.8.20, Host: launchermeta.mojang.com [Info: 2022-05-01 11:52:43.047578241: NetQueue.cpp(551)] NetQueue: Action finished: https://launchermeta.mojang.com/mc/game/version_manifest_v2.json?_t=2022-05-01T11:52:42Z [Info: 2022-05-01 11:52:43.047650041: NetQueue.cpp(579)] NetQueue: Action finalized: https://launchermeta.mojang.com/mc/game/version_manifest_v2.json?_t=2022-05-01T11:52:42Z [Info: 2022-05-01 11:52:43.047907743: GameVersionManager.cpp(432)] Got available versions manifest from https://launchermeta.mojang.com/mc/game/version_manifest_v2.json?_t=2022-05-01T11:52:42Z [Info: 2022-05-01 11:52:43.077295403: NetQueue.cpp(632)] NetQueue: Starting net action https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:52:43.159202049: CefUI.cpp(123)] Web cache is compatible with current CEF version. [Info: 2022-05-01 11:52:43.159389664: CefUI.cpp(145)] Web cache path: $HOME/.minecraft/webcache2 [Info: 2022-05-01 11:52:43.766809547: NetQueue.cpp(472)] NetQueue: Primary ip: 152.199.39.108, Host: piston-meta.mojang.com [Info: 2022-05-01 11:52:43.766955689: NetQueue.cpp(551)] NetQueue: Action finished: https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:52:43.767018538: NetQueue.cpp(579)] NetQueue: Action finalized: https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:52:43.767989310: NetQueue.cpp(632)] NetQueue: Starting net action https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:52:43.921389570: NetQueue.cpp(472)] NetQueue: Primary ip: 152.199.39.108, Host: piston-meta.mojang.com [Info: 2022-05-01 11:52:43.921541566: NetQueue.cpp(551)] NetQueue: Action finished: https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:52:43.921661113: NetQueue.cpp(579)] NetQueue: Action finalized: https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:52:44.154578613: NetQueue.cpp(632)] NetQueue: Starting net action https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:52:44.257470014: NetQueue.cpp(472)] NetQueue: Primary ip: 152.199.39.108, Host: piston-meta.mojang.com [Info: 2022-05-01 11:52:44.257628262: NetQueue.cpp(551)] NetQueue: Action finished: https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:52:44.257710030: NetQueue.cpp(579)] NetQueue: Action finalized: https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:52:44.258700377: NetQueue.cpp(632)] NetQueue: Starting net action https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:52:44.395545383: NetQueue.cpp(472)] NetQueue: Primary ip: 152.199.39.108, Host: piston-meta.mojang.com [Info: 2022-05-01 11:52:44.395684184: NetQueue.cpp(551)] NetQueue: Action finished: https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:52:44.395745455: NetQueue.cpp(579)] NetQueue: Action finalized: https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:52:44.458029245: LauncherAppBrowser.cpp(83)] Will launch a Chromium subprocess with command line string: /home/wangze/.minecraft/launcher/minecraft-launcher --type=zygote --no-zygote-sandbox --no-sandbox --log-severity=info --lang=en-US --user-data-dir=/home/wangze/.config/cef_user_data --log-file=/home/wangze/.minecraft/launcher_cef_log.txt --launcherui --workdir=/home/wangze/.minecraft [Info: 2022-05-01 11:52:44.520720495: LauncherAppBrowser.cpp(83)] Will launch a Chromium subprocess with command line string: /home/wangze/.minecraft/launcher/minecraft-launcher --type=zygote --no-sandbox --log-severity=info --lang=en-US --user-data-dir=/home/wangze/.config/cef_user_data --log-file=/home/wangze/.minecraft/launcher_cef_log.txt --launcherui --workdir=/home/wangze/.minecraft [Info: 2022-05-01 11:52:46.985549594: LauncherAppBrowser.cpp(83)] Will launch a Chromium subprocess with command line string: /proc/self/exe --type=gpu-process --no-sandbox --log-severity=info --lang=en-US --user-data-dir=/home/wangze/.config/cef_user_data --launcherui --workdir=/home/wangze/.minecraft [Info: 2022-05-01 11:52:48.177263464: LauncherAppBrowser.cpp(64)] Work dir is $HOME/.minecraft [Info: 2022-05-01 11:52:48.228411350: main_context.cpp(130)] CEF initialized successfully. [Info: 2022-05-01 11:52:48.228744911: main_context.cpp(132)] CEF version: 99.2.14+g3f796b8+chromium-99.0.4844.84 [Info: 2022-05-01 11:52:48.265325163: Xal.lib(0)] XAL: [op 139952113332384] Operation TryAddFirstUserSilently is starting [Info: 2022-05-01 11:52:48.265560874: Xal.lib(0)] XAL: [op 139952113332384] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:48.332008960: orca_screen_reader.cpp(148)] Orca screen reader: not found. [Info: 2022-05-01 11:52:48.332768062: Xal.lib(0)] XAL: [op 139954327915664] Operation GetDefaultUser is starting [Info: 2022-05-01 11:52:48.332803430: Xal.lib(0)] XAL: [op 139954327915664] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:48.332906827: Xal.lib(0)] XAL: [op 139954327922208] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:48.332926511: Xal.lib(0)] XAL: [op 139954327922208] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:48.333044473: Xal.lib(0)] XAL: [op 139954327917408] Operation LoadClockSkew is starting [Info: 2022-05-01 11:52:48.333071752: Xal.lib(0)] XAL: [op 139954327917408] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:48.333114403: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:48.333165336: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:48.333187708: Xal.lib(0)] XAL: [op 139954327917152] Added operation as handle 0x7f49a80012f4 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:48.333203444: XalStorage.cpp(264)] [op 0x7f49a80012f4] Xal Read callback - Started [Info: 2022-05-01 11:52:48.333222043: XalStorage.cpp(344)] [op 0x7f49a80012f4] Xal Read callback - Failed [Info: 2022-05-01 11:52:48.333374862: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Failure' (1) [Info: 2022-05-01 11:52:48.333399384: Xal.lib(0)] XAL: [op 139954327917152] Cleared operation handle 0x7f49a80012f4 [Info: 2022-05-01 11:52:48.333420829: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation failed with result 0x89235107: Client operation failed [Info: 2022-05-01 11:52:48.434932590: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation continuing [Warning: 2022-05-01 11:52:48.435302401: Xal.lib(0)] XAL: Clock skew failed to be read: 0x89235107 "Client operation failed" [Warning: 2022-05-01 11:52:48.435407349: Xal.lib(0)] XAL: [op 139954327917408] Operation LoadClockSkew failed with result: 0x89235107 - Client operation failed [Info: 2022-05-01 11:52:48.436247657: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:48.436372119: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:48.436511815: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:48.436629902: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:48.436741169: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:48.436814403: Xal.lib(0)] XAL: [op 139954327931152] Added operation as handle 0x7f49a80049a4 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:48.436860195: XalStorage.cpp(264)] [op 0x7f49a80049a4] Xal Read callback - Started [Info: 2022-05-01 11:52:48.436933764: XalStorage.cpp(356)] [op 0x7f49a80049a4] Xal Read callback - Succeeded [Info: 2022-05-01 11:52:48.437385614: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:48.437467358: Xal.lib(0)] XAL: [op 139954327931152] Cleared operation handle 0x7f49a80049a4 [Info: 2022-05-01 11:52:48.437532917: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation succeeded [Info: 2022-05-01 11:52:48.493677587: LauncherAppBrowser.cpp(83)] Will launch a Chromium subprocess with command line string: /proc/self/exe --type=utility --utility-sub-type=storage.mojom.StorageService --lang=zh-CN --service-sandbox-type=utility --no-sandbox --log-severity=info --lang=en-US --user-data-dir=/home/wangze/.config/cef_user_data --launcherui --workdir=/home/wangze/.minecraft [Info: 2022-05-01 11:52:48.538965426: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation continuing [Info: 2022-05-01 11:52:48.598876909: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:48.605949835: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:48.613117906: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:48.613350482: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:48.613544973: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:48.613673659: Xal.lib(0)] XAL: [op 139954327917152] Added operation as handle 0x7f49a80012f4 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:48.613729332: XalStorage.cpp(264)] [op 0x7f49a80012f4] Xal Read callback - Started [Info: 2022-05-01 11:52:48.620126335: XalStorage.cpp(356)] [op 0x7f49a80012f4] Xal Read callback - Succeeded [Info: 2022-05-01 11:52:48.620737503: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:48.620851405: Xal.lib(0)] XAL: [op 139954327917152] Cleared operation handle 0x7f49a80012f4 [Info: 2022-05-01 11:52:48.620925137: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation succeeded [Info: 2022-05-01 11:52:48.722471004: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation continuing [Info: 2022-05-01 11:52:48.722971735: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:48.723096358: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:48.723209791: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:48.723287110: Xal.lib(0)] XAL: [op 139954327931152] Added operation as handle 0x7f49a80049a4 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:48.723334110: XalStorage.cpp(264)] [op 0x7f49a80049a4] Xal Read callback - Started [Info: 2022-05-01 11:52:48.729474455: XalStorage.cpp(356)] [op 0x7f49a80049a4] Xal Read callback - Succeeded [Info: 2022-05-01 11:52:48.730074719: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:48.730262205: Xal.lib(0)] XAL: [op 139954327931152] Cleared operation handle 0x7f49a80049a4 [Info: 2022-05-01 11:52:48.730419246: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation succeeded [Info: 2022-05-01 11:52:48.765497921: LauncherAppBrowser.cpp(83)] Will launch a Chromium subprocess with command line string: /proc/self/exe --type=utility --utility-sub-type=network.mojom.NetworkService --lang=zh-CN --service-sandbox-type=none --no-sandbox --log-severity=info --lang=en-US --user-data-dir=/home/wangze/.config/cef_user_data --launcherui --workdir=/home/wangze/.minecraft [Info: 2022-05-01 11:52:48.832309107: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation continuing [Info: 2022-05-01 11:52:48.832507567: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:48.832648099: Xal.lib(0)] XAL: [op 139954327922208] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:48.832821377: Xal.lib(0)] XAL: [op 139954327977136] Operation LoadDefaultUser is starting [Info: 2022-05-01 11:52:48.832845451: Xal.lib(0)] XAL: [op 139954327977136] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:48.832893374: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:48.832947886: Xal.lib(0)] XAL: [op 139954327931152] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:48.832986518: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:48.833010534: Xal.lib(0)] XAL: [op 139954327917152] Added operation as handle 0x7f49a80012f4 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:48.833027400: XalStorage.cpp(264)] [op 0x7f49a80012f4] Xal Read callback - Started [Info: 2022-05-01 11:52:48.834769888: XalStorage.cpp(356)] [op 0x7f49a80012f4] Xal Read callback - Succeeded [Info: 2022-05-01 11:52:48.834908648: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:48.834933511: Xal.lib(0)] XAL: [op 139954327917152] Cleared operation handle 0x7f49a80012f4 [Info: 2022-05-01 11:52:48.834947511: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation succeeded [Info: 2022-05-01 11:52:48.936271335: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation continuing [Info: 2022-05-01 11:52:48.936619939: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:48.936756663: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:48.936881140: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:48.936959241: Xal.lib(0)] XAL: [op 139954327987968] Added operation as handle 0x7f49a8012794 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:48.937004163: XalStorage.cpp(264)] [op 0x7f49a8012794] Xal Read callback - Started [Info: 2022-05-01 11:52:49.187420287: XalStorage.cpp(356)] [op 0x7f49a8012794] Xal Read callback - Succeeded [Info: 2022-05-01 11:52:49.187732556: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:49.187776933: Xal.lib(0)] XAL: [op 139954327987968] Cleared operation handle 0x7f49a8012794 [Info: 2022-05-01 11:52:49.187805062: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation succeeded [Info: 2022-05-01 11:52:49.289129471: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation continuing [Info: 2022-05-01 11:52:49.289525995: Xal.lib(0)] XAL: [op 139954327977136] Operation LoadDefaultUser succeeded. [Info: 2022-05-01 11:52:49.290137453: Xal.lib(0)] XAL: [op 139954327985824] Operation LoadTokensForUser is starting [Info: 2022-05-01 11:52:49.290216120: Xal.lib(0)] XAL: [op 139954327985824] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:49.290348663: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:49.290465788: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:49.290576395: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:49.290649179: Xal.lib(0)] XAL: [op 139954327917152] Added operation as handle 0x7f49a80012f4 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:49.290695655: XalStorage.cpp(264)] [op 0x7f49a80012f4] Xal Read callback - Started [Info: 2022-05-01 11:52:49.296990323: XalStorage.cpp(356)] [op 0x7f49a80012f4] Xal Read callback - Succeeded [Info: 2022-05-01 11:52:49.297642451: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:49.297814592: Xal.lib(0)] XAL: [op 139954327917152] Cleared operation handle 0x7f49a80012f4 [Info: 2022-05-01 11:52:49.297901734: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation succeeded [Info: 2022-05-01 11:52:49.399622477: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation continuing [Info: 2022-05-01 11:52:49.400555649: Xal.lib(0)] XAL: [op 139954327985824] Operation LoadTokensForUser succeeded. [Info: 2022-05-01 11:52:49.401206404: Xal.lib(0)] XAL: [op 139954328018880] Operation GetXtoken is starting [Info: 2022-05-01 11:52:49.401293094: Xal.lib(0)] XAL: [op 139954328018880] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:49.401744082: Xal.lib(0)] XAL: [op 139954327922208] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:49.401852739: Xal.lib(0)] XAL: [op 139954327922208] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:49.402127939: Xal.lib(0)] XAL: [op 139954327981024] Operation LoadClockSkew is starting [Info: 2022-05-01 11:52:49.402192273: Xal.lib(0)] XAL: [op 139954327981024] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:49.402290293: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:49.402448302: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:49.402609390: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:49.402717195: Xal.lib(0)] XAL: [op 139954327987968] Added operation as handle 0x7f49a8012794 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:49.402784035: XalStorage.cpp(264)] [op 0x7f49a8012794] Xal Read callback - Started [Info: 2022-05-01 11:52:49.402859011: XalStorage.cpp(344)] [op 0x7f49a8012794] Xal Read callback - Failed [Info: 2022-05-01 11:52:49.403636442: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Failure' (1) [Info: 2022-05-01 11:52:49.403788468: Xal.lib(0)] XAL: [op 139954327987968] Cleared operation handle 0x7f49a8012794 [Info: 2022-05-01 11:52:49.403908032: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation failed with result 0x89235107: Client operation failed [Info: 2022-05-01 11:52:49.505646860: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation continuing [Warning: 2022-05-01 11:52:49.505955152: Xal.lib(0)] XAL: Clock skew failed to be read: 0x89235107 "Client operation failed" [Warning: 2022-05-01 11:52:49.506029287: Xal.lib(0)] XAL: [op 139954327981024] Operation LoadClockSkew failed with result: 0x89235107 - Client operation failed [Info: 2022-05-01 11:52:49.506595727: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:49.506695772: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:49.506766716: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:49.507433193: Xal.lib(0)] XAL: [op 139954327982976] Operation NsalDb_LoadDefaultNsal is starting [Info: 2022-05-01 11:52:49.507501167: Xal.lib(0)] XAL: [op 139954327982976] with CV 'ULCH2tLsid2XK/h1.0.0' [Info: 2022-05-01 11:52:49.507938232: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:49.508720672: NetQueue.cpp(632)] NetQueue: Starting net action title.mgt.xboxlive.com [Info: 2022-05-01 11:52:49.952460732: root_window_gtk.cpp(409)] OnBrowserCreated: id=1 [Info: 2022-05-01 11:52:49.992835742: LauncherAppBrowser.cpp(83)] Will launch a Chromium subprocess with command line string: /proc/self/exe --type=renderer --log-severity=info --user-data-dir=/home/wangze/.config/cef_user_data --launcherui --workdir=/home/wangze/.minecraft [Info: 2022-05-01 11:52:49.996851113: LauncherAppBrowser.cpp(83)] Will launch a Chromium subprocess with command line string: /proc/self/exe --type=renderer --log-severity=info --user-data-dir=/home/wangze/.config/cef_user_data --launcherui --workdir=/home/wangze/.minecraft [Info: 2022-05-01 11:52:50.384767303: browser_window_std_gtk.cpp(113)] my_gtk_realize: 0x556da94b1770 [Info: 2022-05-01 11:52:50.726680144: root_window_gtk.cpp(355)] Window icon fixed successfully (AB#474691). [Info: 2022-05-01 11:52:50.726949139: root_window_manager.cpp(62)] Main window has been opened: 0x556da9162390 [Info: 2022-05-01 11:52:50.736025099: NetQueue.cpp(472)] NetQueue: Primary ip: 40.65.111.94, Host: title.mgt.xboxlive.com [Info: 2022-05-01 11:52:50.736130838: NetQueue.cpp(551)] NetQueue: Action finished: title.mgt.xboxlive.com [Info: 2022-05-01 11:52:50.736245264: NetQueue.cpp(579)] NetQueue: Action finalized: title.mgt.xboxlive.com [Info: 2022-05-01 11:52:50.834228851: Xal.lib(0)] XAL: [op 139954327982976] Operation NsalDb_LoadDefaultNsal succeeded. [Info: 2022-05-01 11:52:50.835058592: Xal.lib(0)] XAL: [op 139954327977136] Operation GetDtoken is starting [Info: 2022-05-01 11:52:50.835177522: Xal.lib(0)] XAL: [op 139954327977136] with CV 'ULCH2tLsid2XK/h1.0.1' [Info: 2022-05-01 11:52:50.835261913: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FB1F97EA0C) [Info: 2022-05-01 11:52:50.835399972: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:50.8350000Z, systemNow:2022-05-01T11:52:50.8350000Z} [Info: 2022-05-01 11:52:50.835546213: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FB1F97EA0C) [Info: 2022-05-01 11:52:50.835625358: Xal.lib(0)] XAL: [op 139954327977136] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:50.836029583: Xal.lib(0)] XAL: [op 139954327922208] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:50.836680387: Xal.lib(0)] XAL: [op 139954327977136] Operation GetDtoken is starting [Info: 2022-05-01 11:52:50.836774004: Xal.lib(0)] XAL: [op 139954327977136] with CV 'ULCH2tLsid2XK/h1.0.1' [Info: 2022-05-01 11:52:50.836846364: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FB1FB034FE) [Info: 2022-05-01 11:52:50.836962679: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:50.8360000Z, systemNow:2022-05-01T11:52:50.8360000Z} [Info: 2022-05-01 11:52:50.837045116: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FB1FB034FE) [Info: 2022-05-01 11:52:50.837121263: Xal.lib(0)] XAL: [op 139954327977136] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:50.837742975: Xal.lib(0)] XAL: [op 139954327950352] Operation GetMsaTicket is starting [Info: 2022-05-01 11:52:50.837822445: Xal.lib(0)] XAL: [op 139954327950352] with CV 'ULCH2tLsid2XK/h1.0.1' [Info: 2022-05-01 11:52:50.838118871: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:50.838187953: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.0.1' [Info: 2022-05-01 11:52:50.838458716: Xal.lib(0)] XAL: [op 139954327981024] Operation LoadClockSkew is starting [Info: 2022-05-01 11:52:50.838524538: Xal.lib(0)] XAL: [op 139954327981024] with CV 'ULCH2tLsid2XK/h1.0.1' [Info: 2022-05-01 11:52:50.838636066: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation starting [Info: 2022-05-01 11:52:50.839051508: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation calling platform handler [Info: 2022-05-01 11:52:50.839135233: Xal.lib(0)] XAL: [op 139954327987968] Added operation as handle 0x7f49a8012794 with type 0x7f49a3e37c90 [Info: 2022-05-01 11:52:50.839202660: XalStorage.cpp(264)] [op 0x7f49a8012794] Xal Read callback - Started [Info: 2022-05-01 11:52:50.839262961: XalStorage.cpp(344)] [op 0x7f49a8012794] Xal Read callback - Failed [Info: 2022-05-01 11:52:50.839709271: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Failure' (1) [Info: 2022-05-01 11:52:50.839799379: Xal.lib(0)] XAL: [op 139954327987968] Cleared operation handle 0x7f49a8012794 [Info: 2022-05-01 11:52:50.839866842: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation failed with result 0x89235107: Client operation failed [Info: 2022-05-01 11:52:50.941358458: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation continuing [Warning: 2022-05-01 11:52:50.941620569: Xal.lib(0)] XAL: Clock skew failed to be read: 0x89235107 "Client operation failed" [Warning: 2022-05-01 11:52:50.941697668: Xal.lib(0)] XAL: [op 139954327981024] Operation LoadClockSkew failed with result: 0x89235107 - Client operation failed [Info: 2022-05-01 11:52:50.942264898: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:50.942341512: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.0.1' [Info: 2022-05-01 11:52:50.942412649: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:50.942939938: Xal.lib(0)] XAL: [op 139954327977136] Operation GetDtoken is starting [Info: 2022-05-01 11:52:50.943011022: Xal.lib(0)] XAL: [op 139954327977136] with CV 'ULCH2tLsid2XK/h1.0.1' [Info: 2022-05-01 11:52:50.943069347: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FB2605155D) [Info: 2022-05-01 11:52:50.943153714: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:50.9430000Z, systemNow:2022-05-01T11:52:50.9430000Z} [Info: 2022-05-01 11:52:50.943218134: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FB2605155D) [Info: 2022-05-01 11:52:50.943272596: Xal.lib(0)] XAL: [op 139954327977136] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:50.943561872: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:50.943833116: Xal.lib(0)] XAL: >>> GetTicket (16EAF8FB2610C11A) [Info: 2022-05-01 11:52:50.943922760: Xal.lib(0)] XAL: Found requested token in cache: [firstScope:service::user.auth.xboxlive.com::MBI_SSL]:{expiry:2022-05-02T08:16:02.2478587Z, now:2022-05-01T11:52:50.9430000Z, systemNow:2022-05-01T11:52:50.9430000Z} [Info: 2022-05-01 11:52:50.943982802: Xal.lib(0)] XAL: <<< GetTicket (16EAF8FB2610C11A) [Info: 2022-05-01 11:52:50.944058692: Xal.lib(0)] XAL: [op 139954327950352] Operation GetMsaTicket succeeded. [Info: 2022-05-01 11:52:50.944320277: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FB261833C6) [Info: 2022-05-01 11:52:50.944406618: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Utoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-15T08:16:04.2419549Z, now:2022-05-01T11:52:50.9440000Z, systemNow:2022-05-01T11:52:50.9440000Z} [Info: 2022-05-01 11:52:50.944468483: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FB261833C6) [Info: 2022-05-01 11:52:50.944522811: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FB261B483D) [Info: 2022-05-01 11:52:50.944651080: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Ttoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-15T08:16:04.1862934Z, now:2022-05-01T11:52:50.9440000Z, systemNow:2022-05-01T11:52:50.9440000Z} [Info: 2022-05-01 11:52:50.944725739: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FB261B483D) [Info: 2022-05-01 11:52:50.944984740: Xal.lib(0)] XAL: [op 139954327920928] Refresh Xtoken running with user: true. [Info: 2022-05-01 11:52:50.945046557: Xal.lib(0)] XAL: [op 139954327920928] Operation RefreshXtoken is starting [Info: 2022-05-01 11:52:50.945100466: Xal.lib(0)] XAL: [op 139954327920928] with CV 'ULCH2tLsid2XK/h1.0.1' [Info: 2022-05-01 11:52:50.945152371: Xal.lib(0)] XAL: [op 139954327920928] RefreshXtoken token fetch started. [Info: 2022-05-01 11:52:50.945588202: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:50.945696619: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:50.953987812: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageReadPlatformOperation destroyed [Info: 2022-05-01 11:52:50.954980334: NetQueue.cpp(632)] NetQueue: Starting net action xsts.auth.xboxlive.com [Info: 2022-05-01 11:52:51.663823374: Xal.lib(0)] XAL: [op 139954328066944] Operation UploadTelemetryEvents is starting [Info: 2022-05-01 11:52:51.664220848: Xal.lib(0)] XAL: [op 93929476551824] Operation UploadTelemetryEventsWithDelay succeeded. [Info: 2022-05-01 11:52:51.725856727: NetQueue.cpp(632)] NetQueue: Starting net action vortex.data.microsoft.com [Info: 2022-05-01 11:52:52.649747623: NetQueue.cpp(472)] NetQueue: Primary ip: 20.69.107.178, Host: xsts.auth.xboxlive.com [Info: 2022-05-01 11:52:52.649999258: NetQueue.cpp(551)] NetQueue: Action finished: xsts.auth.xboxlive.com [Info: 2022-05-01 11:52:52.650336991: NetQueue.cpp(579)] NetQueue: Action finalized: xsts.auth.xboxlive.com [Info: 2022-05-01 11:52:52.678914900: Xal.lib(0)] XAL: Clock skew updated. Server time: 2022-05-01T11:52:52.4062238Z - System time: 2022-05-01T11:52:52.6780000Z = skew (seconds) 0 [Info: 2022-05-01 11:52:52.679270456: Xal.lib(0)] XAL: [op 139954327927776] Operation SaveClockSkew is starting [Info: 2022-05-01 11:52:52.679350550: Xal.lib(0)] XAL: [op 139954327927776] with CV 'ULCH2tLsid2XK/h1.0.2' [Info: 2022-05-01 11:52:52.679505227: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation starting [Info: 2022-05-01 11:52:52.679680061: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation calling platform handler [Info: 2022-05-01 11:52:52.679758789: Xal.lib(0)] XAL: [op 139954327987968] Added operation as handle 0x7f49a8012794 with type 0x7f49a3e37ca0 [Info: 2022-05-01 11:52:52.679829208: XalStorage.cpp(205)] [op 0x7f49a8012794] Xal Write callback - Started [Info: 2022-05-01 11:52:52.680384454: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:52.680475171: Xal.lib(0)] XAL: [op 139954327987968] Cleared operation handle 0x7f49a8012794 [Info: 2022-05-01 11:52:52.680542618: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation succeeded [Info: 2022-05-01 11:52:52.680789456: XalStorage.cpp(258)] [op 0x7f49a8012794] Xal Write callback - Succeeded [Info: 2022-05-01 11:52:52.782209833: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation continuing [Info: 2022-05-01 11:52:52.782446776: Xal.lib(0)] XAL: [op 139954327927776] Operation SaveClockSkew succeeded. [Info: 2022-05-01 11:52:52.783401641: Xal.lib(0)] XAL: [op 139954327934704] Operation WriteCacheData is starting [Info: 2022-05-01 11:52:52.783482626: Xal.lib(0)] XAL: [op 139954327934704] with CV 'ULCH2tLsid2XK/h1.0.2' [Info: 2022-05-01 11:52:52.783580132: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation starting [Info: 2022-05-01 11:52:52.783697272: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation destroyed [Info: 2022-05-01 11:52:52.783780958: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation calling platform handler [Info: 2022-05-01 11:52:52.783851702: Xal.lib(0)] XAL: [op 139954327917152] Added operation as handle 0x7f49a80012f4 with type 0x7f49a3e37ca0 [Info: 2022-05-01 11:52:52.783897384: XalStorage.cpp(205)] [op 0x7f49a80012f4] Xal Write callback - Started [Info: 2022-05-01 11:52:53.014047462: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:53.014092599: Xal.lib(0)] XAL: [op 139954327917152] Cleared operation handle 0x7f49a80012f4 [Info: 2022-05-01 11:52:53.014117401: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation succeeded [Info: 2022-05-01 11:52:53.014197530: XalStorage.cpp(246)] [op 0x7f49a80012f4] Xal Write callback - Succeeded [Info: 2022-05-01 11:52:53.115492358: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation continuing [Info: 2022-05-01 11:52:53.115557140: Xal.lib(0)] XAL: [op 139954327934704] Operation WriteCacheData succeeded. [Info: 2022-05-01 11:52:53.115641393: Xal.lib(0)] XAL: [op 139954327920928] RefreshXtoken token fetch done. [Info: 2022-05-01 11:52:53.115654929: Xal.lib(0)] XAL: [op 139954327920928] Operation RefreshXtoken succeeded. [Info: 2022-05-01 11:52:53.115788691: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:53.115811583: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:53.117246841: Xal.lib(0)] XAL: [op 139954327981024] Operation NsalDb_LoadTitleNsal is starting [Info: 2022-05-01 11:52:53.117266290: Xal.lib(0)] XAL: [op 139954327981024] with CV 'ULCH2tLsid2XK/h1.0.2' [Info: 2022-05-01 11:52:53.117352500: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation destroyed [Info: 2022-05-01 11:52:53.394565410: NetQueue.cpp(632)] NetQueue: Starting net action title.mgt.xboxlive.com [Info: 2022-05-01 11:52:53.803339443: NetQueue.cpp(472)] NetQueue: Primary ip: 40.65.111.94, Host: title.mgt.xboxlive.com [Info: 2022-05-01 11:52:53.803520586: NetQueue.cpp(551)] NetQueue: Action finished: title.mgt.xboxlive.com [Info: 2022-05-01 11:52:53.803850213: NetQueue.cpp(579)] NetQueue: Action finalized: title.mgt.xboxlive.com [Info: 2022-05-01 11:52:53.804343475: NetQueue.cpp(472)] NetQueue: Primary ip: 40.77.226.250, Host: vortex.data.microsoft.com [Info: 2022-05-01 11:52:53.804442789: NetQueue.cpp(551)] NetQueue: Action finished: vortex.data.microsoft.com [Info: 2022-05-01 11:52:53.804654449: NetQueue.cpp(579)] NetQueue: Action finalized: vortex.data.microsoft.com [Info: 2022-05-01 11:52:53.827726973: Xal.lib(0)] XAL: No signature policies found in NSAL document [Info: 2022-05-01 11:52:53.827980615: Xal.lib(0)] XAL: [op 139954327981024] Operation NsalDb_LoadTitleNsal succeeded. [Info: 2022-05-01 11:52:53.828306066: Xal.lib(0)] XAL: [op 139954328018880] Operation GetXtoken succeeded. [Info: 2022-05-01 11:52:53.828641635: Xal.lib(0)] XAL: [op 139954327915664] Operation GetDefaultUser succeeded. [Info: 2022-05-01 11:52:53.829308808: Xal.lib(0)] XAL: [op 139954327991120] Operation PresenceHeartbeat is starting [Info: 2022-05-01 11:52:53.829382464: Xal.lib(0)] XAL: [op 139954327991120] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.829676347: Xal.lib(0)] XAL: [op 139954328099568] GetTokenAndSignature being run for usertype: User [Info: 2022-05-01 11:52:53.829768224: Xal.lib(0)] XAL: [op 139954328099568] Operation GetTokenAndSignature is starting [Info: 2022-05-01 11:52:53.829823923: Xal.lib(0)] XAL: [op 139954328099568] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.830071051: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:53.830132664: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.830451821: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:53.830515561: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.830579911: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:53.831094371: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken is starting [Info: 2022-05-01 11:52:53.831161123: Xal.lib(0)] XAL: [op 139954327920592] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.831317819: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBD22C3480) [Info: 2022-05-01 11:52:53.831408024: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:53.5592238Z, systemNow:2022-05-01T11:52:53.8310000Z} [Info: 2022-05-01 11:52:53.831509358: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBD22C3480) [Info: 2022-05-01 11:52:53.831568410: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:53.831862666: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:53.832463253: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:53.832632030: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:53.840699097: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBD2BAE6CC) [Info: 2022-05-01 11:52:53.840858664: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Xtoken, relyingParty:http://xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:true hasData:true, isValid:true, xerr:0, expiry:2022-05-02T03:52:52.4062238Z, now:2022-05-01T11:52:53.5682238Z, systemNow:2022-05-01T11:52:53.8400000Z} [Info: 2022-05-01 11:52:53.840933541: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBD2BAE6CC) [Info: 2022-05-01 11:52:53.841383964: Xal.lib(0)] XAL: [op 139954328090160] Operation GetXtoken is starting [Info: 2022-05-01 11:52:53.841515244: Xal.lib(0)] XAL: [op 139954328090160] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.841966853: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:53.842094547: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.842700526: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:53.842835150: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.842980752: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:53.843890914: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken is starting [Info: 2022-05-01 11:52:53.844045383: Xal.lib(0)] XAL: [op 139954327920592] with CV 'ULCH2tLsid2XK/h1.13.0' [Info: 2022-05-01 11:52:53.844180371: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBD2F000E3) [Info: 2022-05-01 11:52:53.844379415: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:53.5722238Z, systemNow:2022-05-01T11:52:53.8440000Z} [Info: 2022-05-01 11:52:53.844468568: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBD2F000E3) [Info: 2022-05-01 11:52:53.844526609: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:53.845359071: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:53.845754683: Xal.lib(0)] XAL: [op 139954328090160] Operation GetXtoken succeeded. [Info: 2022-05-01 11:52:53.846133769: Xal.lib(0)] XAL: [op 139954328099568] Operation GetTokenAndSignature succeeded. [Info: 2022-05-01 11:52:53.846826639: Xal.lib(0)] XAL: [op 139952113332384] Operation TryAddFirstUserSilently succeeded. [Info: 2022-05-01 11:52:53.847322000: Xal.lib(0)] XAL: [op 139954328064624] Operation UploadTelemetryEventsWithDelay is starting [Info: 2022-05-01 11:52:53.847704275: Xal.lib(0)] XAL: [op 139954327952656] Operation TryRefreshUser is starting [Info: 2022-05-01 11:52:53.847778601: Xal.lib(0)] XAL: [op 139954327952656] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.848076231: Xal.lib(0)] XAL: [op 139954328019936] GetTokenAndSignature being run for usertype: User [Info: 2022-05-01 11:52:53.848193825: Xal.lib(0)] XAL: [op 139954328019936] Operation GetTokenAndSignature is starting [Info: 2022-05-01 11:52:53.848232169: Xal.lib(0)] XAL: [op 139954328019936] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.848380704: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:53.848416945: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.848593685: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:53.848629268: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.848665285: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:53.848952374: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken is starting [Info: 2022-05-01 11:52:53.848989034: Xal.lib(0)] XAL: [op 139954327920592] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.849020825: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBD33A7A98) [Info: 2022-05-01 11:52:53.849066269: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:53.5772238Z, systemNow:2022-05-01T11:52:53.8490000Z} [Info: 2022-05-01 11:52:53.849101073: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBD33A7A98) [Info: 2022-05-01 11:52:53.849131014: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:53.849312101: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:53.849527393: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:53.849619894: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:53.853986953: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBD385E975) [Info: 2022-05-01 11:52:53.854141270: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Xtoken, relyingParty:http://xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:true hasData:true, isValid:true, xerr:0, expiry:2022-05-02T03:52:52.4062238Z, now:2022-05-01T11:52:53.5822238Z, systemNow:2022-05-01T11:52:53.8540000Z} [Info: 2022-05-01 11:52:53.854225422: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBD385E975) [Info: 2022-05-01 11:52:53.854398523: Xal.lib(0)] XAL: [op 139954328090160] Operation GetXtoken is starting [Info: 2022-05-01 11:52:53.854444324: Xal.lib(0)] XAL: [op 139954328090160] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.854564481: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:53.854645796: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.854855365: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:53.854910474: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.854954041: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:53.855332673: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken is starting [Info: 2022-05-01 11:52:53.855401845: Xal.lib(0)] XAL: [op 139954327920592] with CV 'ULCH2tLsid2XK/h1.14.0' [Info: 2022-05-01 11:52:53.855460346: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBD39CB7D8) [Info: 2022-05-01 11:52:53.855532836: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:53.5832238Z, systemNow:2022-05-01T11:52:53.8550000Z} [Info: 2022-05-01 11:52:53.855614670: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBD39CB7D8) [Info: 2022-05-01 11:52:53.855673818: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:53.855905806: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:53.856195868: Xal.lib(0)] XAL: [op 139954328090160] Operation GetXtoken succeeded. [Info: 2022-05-01 11:52:53.856527235: Xal.lib(0)] XAL: [op 139954328019936] Operation GetTokenAndSignature succeeded. [Info: 2022-05-01 11:52:53.856882170: Xal.lib(0)] XAL: [op 139954327952656] Operation TryRefreshUser succeeded. [Info: 2022-05-01 11:52:53.857311863: Xal.lib(0)] XAL: XalTryAddDefaultUserSilentlyAsync calling back to client with result 'Ok' (0x00000000) [Info: 2022-05-01 11:52:53.857599007: Xal.lib(0)] XAL: [op 139954328066944] Operation UploadTelemetryEvents succeeded. [Info: 2022-05-01 11:52:53.857680046: Xal.lib(0)] XAL: [op 139954328110768] Operation UploadTelemetryEvents is starting [Info: 2022-05-01 11:52:53.858096847: NetQueue.cpp(632)] NetQueue: Starting net action userpresence.xboxlive.com [Info: 2022-05-01 11:52:53.858236648: Xal.lib(0)] XAL: Handle 0x5e800001 to user 1209797042088443905 created [Info: 2022-05-01 11:52:53.858714843: Xal.lib(0)] XAL: [op 139952247551344] Operation StateGetTokenAndSignature is starting [Info: 2022-05-01 11:52:53.858777354: Xal.lib(0)] XAL: [op 139952247551344] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.859360266: NetQueue.cpp(632)] NetQueue: Starting net action vortex.data.microsoft.com [Info: 2022-05-01 11:52:53.960319875: Xal.lib(0)] XAL: [op 139954328097248] GetTokenAndSignature being run for usertype: User [Info: 2022-05-01 11:52:53.960571275: Xal.lib(0)] XAL: [op 139954328097248] Operation GetTokenAndSignature is starting [Info: 2022-05-01 11:52:53.960692503: Xal.lib(0)] XAL: [op 139954328097248] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.961025787: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:53.961132704: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.961504614: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:53.961610915: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.961718009: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:53.962300543: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken is starting [Info: 2022-05-01 11:52:53.962416886: Xal.lib(0)] XAL: [op 139954327920592] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.962522295: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBD9FE45BF) [Info: 2022-05-01 11:52:53.962654685: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:53.6902238Z, systemNow:2022-05-01T11:52:53.9620000Z} [Info: 2022-05-01 11:52:53.962759469: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBD9FE45BF) [Info: 2022-05-01 11:52:53.962866633: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:53.963211310: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:53.963581667: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBDA0E708A) [Info: 2022-05-01 11:52:53.963715376: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Xtoken, relyingParty:rp://api.minecraftservices.com/, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-02T00:20:31.8510287Z, now:2022-05-01T11:52:53.6912238Z, systemNow:2022-05-01T11:52:53.9630000Z} [Info: 2022-05-01 11:52:53.963867743: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBDA0E708A) [Info: 2022-05-01 11:52:53.964281270: Xal.lib(0)] XAL: [op 139954328018880] Operation GetXtoken is starting [Info: 2022-05-01 11:52:53.964398861: Xal.lib(0)] XAL: [op 139954328018880] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.964844400: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:53.964979391: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.965493791: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:53.965646113: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.965777953: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:53.966524390: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken is starting [Info: 2022-05-01 11:52:53.966643998: Xal.lib(0)] XAL: [op 139954327920592] with CV 'ULCH2tLsid2XK/h1.17.0' [Info: 2022-05-01 11:52:53.966740287: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FBDA3EA31C) [Info: 2022-05-01 11:52:53.966861124: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:53.6942238Z, systemNow:2022-05-01T11:52:53.9660000Z} [Info: 2022-05-01 11:52:53.966966216: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FBDA3EA31C) [Info: 2022-05-01 11:52:53.967060932: Xal.lib(0)] XAL: [op 139954327920592] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:53.967475210: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:53.967914956: Xal.lib(0)] XAL: [op 139954328018880] Operation GetXtoken succeeded. [Info: 2022-05-01 11:52:53.968472932: Xal.lib(0)] XAL: [op 139954328097248] Operation GetTokenAndSignature succeeded. [Info: 2022-05-01 11:52:53.968862819: Xal.lib(0)] XAL: [op 139952247551344] Operation StateGetTokenAndSignature succeeded. [Info: 2022-05-01 11:52:53.969364547: Xal.lib(0)] XAL: XalUserGetTokenAndSignatureSilentlyAsync calling back to client with result 'Ok' (0x00000000) [Info: 2022-05-01 11:52:53.970504284: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/launcher/login [Info: 2022-05-01 11:52:44.570929927: LauncherMain.cpp(107)] Initiated models [Info: 2022-05-01 11:52:44.571234716: LauncherController.cpp(468)] Constructing launcher controller with workDir: /.../.minecraft, isActive: 0 [Info: 2022-05-01 11:52:52.204096173: LauncherAppRenderer.cpp(172)] Javascript bridge extended in OnWebKitInitialized. [Info: 2022-05-01 11:52:53.926009240: LauncherAppRenderer.cpp(314)] OnContextCreated: main frame. Url=mojang://launcher/index.html browser id=1 [Info: 2022-05-01 11:52:53.926041767: LauncherAppRenderer.cpp(319)] OnContextCreated: Create JS bindings in main browser. [Info: 2022-05-01 11:52:53.973319116: LauncherAppRenderer.cpp(499)] Javascript bridge extended in OnContextCreated. [Info: 2022-05-01 11:52:54.610827042: NetQueue.cpp(472)] NetQueue: Primary ip: 40.77.226.250, Host: vortex.data.microsoft.com [Info: 2022-05-01 11:52:54.610916025: NetQueue.cpp(551)] NetQueue: Action finished: vortex.data.microsoft.com [Info: 2022-05-01 11:52:54.611014569: NetQueue.cpp(579)] NetQueue: Action finalized: vortex.data.microsoft.com [Info: 2022-05-01 11:52:54.678095644: Xal.lib(0)] XAL: [op 139954328110768] Operation UploadTelemetryEvents succeeded. [Info: 2022-05-01 11:52:54.678233355: Xal.lib(0)] XAL: [op 139954328028848] Operation UploadTelemetryEvents is starting [Info: 2022-05-01 11:52:54.678298949: Xal.lib(0)] XAL: [op 139954328028848] Operation UploadTelemetryEvents succeeded. [Info: 2022-05-01 11:52:54.901629052: ControllerInterface.cpp(106)] Running method getStore [Info: 2022-05-01 11:52:54.904009334: ControllerInterface.cpp(106)] Running method getStore [Info: 2022-05-01 11:52:54.943387613: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:52:54.943435361: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/launcher/login [Info: 2022-05-01 11:52:54.943511763: MinecraftServicesApi.cpp(440)] Signed in to minecraft services with user 3c7c5df5-50ad-4fbe-a6e0-653ad74831ad [Info: 2022-05-01 11:52:54.943551281: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/launcher/login [Info: 2022-05-01 11:52:54.943798048: Xal.lib(0)] XAL: [op 139951912008656] Operation GetGamerPicture is starting [Info: 2022-05-01 11:52:54.943834362: Xal.lib(0)] XAL: [op 139951912008656] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.969100794: ControllerInterface.cpp(106)] Running method checkForUpdates [Info: 2022-05-01 11:52:54.969288952: client_handler.cpp(423)] Handling PostTelemetryEvent message [Info: 2022-05-01 11:52:54.969301788: NetQueue.cpp(632)] NetQueue: Starting net action https://launchermeta.mojang.com/v1/products/launcher/6f083b80d5e6fabbc4236f81d0d8f8a350c665a9/linux.json [Info: 2022-05-01 11:52:54.975838795: ControllerInterface.cpp(106)] Running method getAccountData [Info: 2022-05-01 11:52:54.982114249: Xal.lib(0)] XAL: [op 139954328009648] Operation FetchGamerpicOperation is starting [Info: 2022-05-01 11:52:54.982164030: Xal.lib(0)] XAL: [op 139954328009648] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.982240001: Xal.lib(0)] XAL: [op 139954328097248] GetTokenAndSignature being run for usertype: User [Info: 2022-05-01 11:52:54.982272565: Xal.lib(0)] XAL: [op 139954328097248] Operation GetTokenAndSignature is starting [Info: 2022-05-01 11:52:54.982302565: Xal.lib(0)] XAL: [op 139954328097248] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.982385811: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:54.982408226: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.982480715: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:54.982501185: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.982522590: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:54.982630366: Xal.lib(0)] XAL: [op 139952247551344] Operation GetDtoken is starting [Info: 2022-05-01 11:52:54.982652006: Xal.lib(0)] XAL: [op 139952247551344] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.982672168: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FC16CCB3EB) [Info: 2022-05-01 11:52:54.982698832: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:54.7102238Z, systemNow:2022-05-01T11:52:54.9820000Z} [Info: 2022-05-01 11:52:54.982719180: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FC16CCB3EB) [Info: 2022-05-01 11:52:54.982737288: Xal.lib(0)] XAL: [op 139952247551344] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:54.982801169: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:54.982886058: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:54.982917668: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:54.984335275: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FC16E5E822) [Info: 2022-05-01 11:52:54.984383657: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Xtoken, relyingParty:http://xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:true hasData:true, isValid:true, xerr:0, expiry:2022-05-02T03:52:52.4062238Z, now:2022-05-01T11:52:54.7122238Z, systemNow:2022-05-01T11:52:54.9840000Z} [Info: 2022-05-01 11:52:54.984417856: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FC16E5E822) [Info: 2022-05-01 11:52:54.984494038: Xal.lib(0)] XAL: [op 139954328018880] Operation GetXtoken is starting [Info: 2022-05-01 11:52:54.984514500: Xal.lib(0)] XAL: [op 139954328018880] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.984570533: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:54.984608283: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.984679885: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:54.984699895: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.984719645: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:54.984823909: Xal.lib(0)] XAL: [op 139952247551344] Operation GetDtoken is starting [Info: 2022-05-01 11:52:54.984843852: Xal.lib(0)] XAL: [op 139952247551344] with CV 'ULCH2tLsid2XK/h1.18.0' [Info: 2022-05-01 11:52:54.984862674: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FC16EE217A) [Info: 2022-05-01 11:52:54.984885402: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:54.7122238Z, systemNow:2022-05-01T11:52:54.9840000Z} [Info: 2022-05-01 11:52:54.984905507: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FC16EE217A) [Info: 2022-05-01 11:52:54.984923223: Xal.lib(0)] XAL: [op 139952247551344] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:54.984985375: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:54.985056032: Xal.lib(0)] XAL: [op 139954328018880] Operation GetXtoken succeeded. [Info: 2022-05-01 11:52:54.985133684: Xal.lib(0)] XAL: [op 139954328097248] Operation GetTokenAndSignature succeeded. [Info: 2022-05-01 11:52:55.034475815: NetQueue.cpp(632)] NetQueue: Starting net action profile.xboxlive.com [Info: 2022-05-01 11:52:55.035830690: NetQueue.cpp(472)] NetQueue: Primary ip: 13.107.42.15, Host: userpresence.xboxlive.com [Info: 2022-05-01 11:52:55.035902292: NetQueue.cpp(551)] NetQueue: Action finished: userpresence.xboxlive.com [Info: 2022-05-01 11:52:55.035958368: NetQueue.cpp(579)] NetQueue: Action finalized: userpresence.xboxlive.com [Info: 2022-05-01 11:52:55.067643640: NetQueue.cpp(472)] NetQueue: Primary ip: 13.35.8.20, Host: launchermeta.mojang.com [Info: 2022-05-01 11:52:55.067769524: NetQueue.cpp(551)] NetQueue: Action finished: https://launchermeta.mojang.com/v1/products/launcher/6f083b80d5e6fabbc4236f81d0d8f8a350c665a9/linux.json [Info: 2022-05-01 11:52:55.068605271: NetQueue.cpp(579)] NetQueue: Action finalized: https://launchermeta.mojang.com/v1/products/launcher/6f083b80d5e6fabbc4236f81d0d8f8a350c665a9/linux.json [Info: 2022-05-01 11:52:55.326585403: ControllerInterface.cpp(106)] Running method gamecoreLauncherInstallState [Info: 2022-05-01 11:52:55.326856106: LauncherController.cpp(1269)] Windows Store Launcher is NotSupported [Info: 2022-05-01 11:52:55.333139148: ControllerInterface.cpp(106)] Running method setStore [Info: 2022-05-01 11:52:56.285223097: NetQueue.cpp(472)] NetQueue: Primary ip: 13.107.42.15, Host: profile.xboxlive.com [Info: 2022-05-01 11:52:56.285711508: NetQueue.cpp(551)] NetQueue: Action finished: profile.xboxlive.com [Info: 2022-05-01 11:52:56.286087281: NetQueue.cpp(579)] NetQueue: Action finalized: profile.xboxlive.com [Info: 2022-05-01 11:52:56.304689382: NetQueue.cpp(632)] NetQueue: Starting net action images-eds-ssl.xboxlive.com [Info: 2022-05-01 11:52:56.613261437: ControllerInterface.cpp(106)] Running method reportLatency [Info: 2022-05-01 11:52:56.661231037: ControllerInterface.cpp(106)] Running method reportLatency [Info: 2022-05-01 11:52:56.662387085: ControllerInterface.cpp(106)] Running method reportLatency [Info: 2022-05-01 11:52:56.685754489: ControllerInterface.cpp(106)] Running method reportLatency [Info: 2022-05-01 11:52:56.835562918: NetQueue.cpp(472)] NetQueue: Primary ip: 23.206.200.10, Host: images-eds-ssl.xboxlive.com [Info: 2022-05-01 11:52:56.835966345: NetQueue.cpp(551)] NetQueue: Action finished: images-eds-ssl.xboxlive.com [Info: 2022-05-01 11:52:56.836434339: NetQueue.cpp(579)] NetQueue: Action finalized: images-eds-ssl.xboxlive.com [Warning: 2022-05-01 11:52:56.914433371: Xal.lib(0)] XAL: Received a different CV on service response. original:'ULCH2tLsid2XK/h1.18.1' received:'oEGgDGUq+mv6YXLI.43.1.0' [Info: 2022-05-01 11:52:56.914717457: Xal.lib(0)] XAL: [op 139954328009648] Operation FetchGamerpicOperation succeeded. [Info: 2022-05-01 11:52:56.915113524: Xal.lib(0)] XAL: [op 139951912008656] Operation GetGamerPicture succeeded. [Info: 2022-05-01 11:52:56.915620935: Xal.lib(0)] XAL: XalUserGetGamerPictureAsync calling back to client with result 'Ok' (0x00000000) [Info: 2022-05-01 11:52:56.927461344: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:52:57.296852856: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:52:57.297036897: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:52:57.297444513: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:52:57.659956706: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:57.660962545: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/entitlements/license?requestId=c150616c-9378-4eaa-8c5e-ced4c3ce2d6c [Info: 2022-05-01 11:52:58.493206032: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:52:58.493367597: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/entitlements/license?requestId=c150616c-9378-4eaa-8c5e-ced4c3ce2d6c [Info: 2022-05-01 11:52:58.493627735: MinecraftServicesApi.cpp(540)] Got entitlements response! [Info: 2022-05-01 11:52:58.552574603: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/entitlements/license?requestId=c150616c-9378-4eaa-8c5e-ced4c3ce2d6c [Info: 2022-05-01 11:52:58.849682421: UnifiedMSAAccounts.cpp(510)] Broadcasting change due to new [forced:1] Entitlements for 0680130a26244484904b22209a0246be [Info: 2022-05-01 11:52:58.851082830: Xal.lib(0)] XAL: [op 139951777792704] Operation StateGetTokenAndSignature is starting [Info: 2022-05-01 11:52:58.851330581: Xal.lib(0)] XAL: [op 139951777792704] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.854010795: ControllerInterface.cpp(106)] Running method getAccountData [Info: 2022-05-01 11:52:58.943117695: Xal.lib(0)] XAL: [op 139954328022256] GetTokenAndSignature being run for usertype: User [Info: 2022-05-01 11:52:58.943347419: Xal.lib(0)] XAL: [op 139954328022256] Operation GetTokenAndSignature is starting [Info: 2022-05-01 11:52:58.943458205: Xal.lib(0)] XAL: [op 139954328022256] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.943769213: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:58.943875680: Xal.lib(0)] XAL: [op 139954328008240] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.944274131: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:58.944384124: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.944532760: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:58.945207587: Xal.lib(0)] XAL: [op 139954328085184] Operation GetDtoken is starting [Info: 2022-05-01 11:52:58.945320094: Xal.lib(0)] XAL: [op 139954328085184] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.945417740: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FD02FF38C1) [Info: 2022-05-01 11:52:58.945542032: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:58.6732238Z, systemNow:2022-05-01T11:52:58.9450000Z} [Info: 2022-05-01 11:52:58.945648248: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FD02FF38C1) [Info: 2022-05-01 11:52:58.945743398: Xal.lib(0)] XAL: [op 139954328085184] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:58.946071552: Xal.lib(0)] XAL: [op 139954328008240] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:58.946442970: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FD030EDF9C) [Info: 2022-05-01 11:52:58.946577976: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Xtoken, relyingParty:rp://api.minecraftservices.com/, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-02T00:20:31.8510287Z, now:2022-05-01T11:52:58.6742238Z, systemNow:2022-05-01T11:52:58.9460000Z} [Info: 2022-05-01 11:52:58.946682728: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FD030EDF9C) [Info: 2022-05-01 11:52:58.946979398: Xal.lib(0)] XAL: [op 139954328018880] Operation GetXtoken is starting [Info: 2022-05-01 11:52:58.947080615: Xal.lib(0)] XAL: [op 139954328018880] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.947366640: Xal.lib(0)] XAL: [op 139954327939952] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:58.947468273: Xal.lib(0)] XAL: [op 139954327939952] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.947823764: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:58.947927253: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.948032645: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:58.948576848: Xal.lib(0)] XAL: [op 139954328085184] Operation GetDtoken is starting [Info: 2022-05-01 11:52:58.948679538: Xal.lib(0)] XAL: [op 139954328085184] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.948780472: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FD03328AF9) [Info: 2022-05-01 11:52:58.948899143: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:58.6762238Z, systemNow:2022-05-01T11:52:58.9480000Z} [Info: 2022-05-01 11:52:58.949002698: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FD03328AF9) [Info: 2022-05-01 11:52:58.949096649: Xal.lib(0)] XAL: [op 139954328085184] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:58.949415742: Xal.lib(0)] XAL: [op 139954327939952] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:58.949921412: Xal.lib(0)] XAL: [op 139954328085184] Operation GetDtoken is starting [Info: 2022-05-01 11:52:58.950024472: Xal.lib(0)] XAL: [op 139954328085184] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.950118098: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FD0346F62D) [Info: 2022-05-01 11:52:58.950235537: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:58.6782238Z, systemNow:2022-05-01T11:52:58.9500000Z} [Info: 2022-05-01 11:52:58.950371557: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FD0346F62D) [Info: 2022-05-01 11:52:58.950468273: Xal.lib(0)] XAL: [op 139954328085184] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:58.951025154: Xal.lib(0)] XAL: [op 139954327950352] Operation GetMsaTicket is starting [Info: 2022-05-01 11:52:58.951267209: Xal.lib(0)] XAL: [op 139954327950352] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.951870618: Xal.lib(0)] XAL: [op 139954327939952] Operation InitializeTokenStack is starting [Info: 2022-05-01 11:52:58.952052556: Xal.lib(0)] XAL: [op 139954327939952] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.952842698: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity is starting [Info: 2022-05-01 11:52:58.953002283: Xal.lib(0)] XAL: [op 139954327955408] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.953127655: Xal.lib(0)] XAL: [op 139954327955408] Operation LoadDeviceIdentity succeeded. [Info: 2022-05-01 11:52:58.954095545: Xal.lib(0)] XAL: [op 139954328085184] Operation GetDtoken is starting [Info: 2022-05-01 11:52:58.954303019: Xal.lib(0)] XAL: [op 139954328085184] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.954482037: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FD03894778) [Info: 2022-05-01 11:52:58.954985005: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Dtoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-07T09:42:16.7121565Z, now:2022-05-01T11:52:58.6822238Z, systemNow:2022-05-01T11:52:58.9540000Z} [Info: 2022-05-01 11:52:58.955188961: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FD03894778) [Info: 2022-05-01 11:52:58.955364198: Xal.lib(0)] XAL: [op 139954328085184] Operation GetDtoken succeeded. [Info: 2022-05-01 11:52:58.955963585: Xal.lib(0)] XAL: [op 139954327939952] Operation InitializeTokenStack succeeded. [Info: 2022-05-01 11:52:58.956584756: Xal.lib(0)] XAL: >>> GetTicket (16EAF8FD03A973F2) [Info: 2022-05-01 11:52:58.956817162: Xal.lib(0)] XAL: Found requested token in cache: [firstScope:service::user.auth.xboxlive.com::MBI_SSL]:{expiry:2022-05-02T08:16:02.2478587Z, now:2022-05-01T11:52:58.6842238Z, systemNow:2022-05-01T11:52:58.9560000Z} [Info: 2022-05-01 11:52:58.956993364: Xal.lib(0)] XAL: <<< GetTicket (16EAF8FD03A973F2) [Info: 2022-05-01 11:52:58.957199491: Xal.lib(0)] XAL: [op 139954327950352] Operation GetMsaTicket succeeded. [Info: 2022-05-01 11:52:58.957793728: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FD03BBEC85) [Info: 2022-05-01 11:52:58.958023104: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Utoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-15T08:16:04.2419549Z, now:2022-05-01T11:52:58.6852238Z, systemNow:2022-05-01T11:52:58.9570000Z} [Info: 2022-05-01 11:52:58.958236707: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FD03BBEC85) [Info: 2022-05-01 11:52:58.958411016: Xal.lib(0)] XAL: >>> GetTokenInternal (16EAF8FD03C54307) [Info: 2022-05-01 11:52:58.958616659: Xal.lib(0)] XAL: Returning requested cache: [hasSignInDisplayClaims:false identityType:Ttoken, relyingParty:http://auth.xboxlive.com, subRelyingParty:, tokenType:JWT]:{HasSignInDisplayClaims:false hasData:true, isValid:true, xerr:0, expiry:2022-05-15T08:16:04.1862934Z, now:2022-05-01T11:52:58.6862238Z, systemNow:2022-05-01T11:52:58.9580000Z} [Info: 2022-05-01 11:52:58.958797077: Xal.lib(0)] XAL: <<< GetTokenInternal (16EAF8FD03C54307) [Info: 2022-05-01 11:52:58.959371636: Xal.lib(0)] XAL: [op 139954327921664] Refresh Xtoken running with user: true. [Info: 2022-05-01 11:52:58.959539464: Xal.lib(0)] XAL: [op 139954327921664] Operation RefreshXtoken is starting [Info: 2022-05-01 11:52:58.959641406: Xal.lib(0)] XAL: [op 139954327921664] with CV 'ULCH2tLsid2XK/h1.19.0' [Info: 2022-05-01 11:52:58.959775107: Xal.lib(0)] XAL: [op 139954327921664] RefreshXtoken token fetch started. [Info: 2022-05-01 11:52:58.960257433: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:58.960598531: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:52:58.971594346: NetQueue.cpp(632)] NetQueue: Starting net action xsts.auth.xboxlive.com [Info: 2022-05-01 11:53:00.563645815: NetQueue.cpp(472)] NetQueue: Primary ip: 20.69.107.178, Host: xsts.auth.xboxlive.com [Info: 2022-05-01 11:53:00.563755228: NetQueue.cpp(551)] NetQueue: Action finished: xsts.auth.xboxlive.com [Info: 2022-05-01 11:53:00.563885007: NetQueue.cpp(579)] NetQueue: Action finalized: xsts.auth.xboxlive.com [Info: 2022-05-01 11:53:00.607734431: Xal.lib(0)] XAL: Clock skew updated. Server time: 2022-05-01T11:53:00.3887661Z - System time: 2022-05-01T11:53:00.6070000Z = skew (seconds) 0 [Info: 2022-05-01 11:53:00.608470341: Xal.lib(0)] XAL: [op 139954328063456] Operation SaveClockSkew is starting [Info: 2022-05-01 11:53:00.608698428: Xal.lib(0)] XAL: [op 139954328063456] with CV 'ULCH2tLsid2XK/h1.19.1' [Info: 2022-05-01 11:53:00.608938071: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation starting [Info: 2022-05-01 11:53:00.609224305: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation calling platform handler [Info: 2022-05-01 11:53:00.609376471: Xal.lib(0)] XAL: [op 139954327987968] Added operation as handle 0x7f49a8012794 with type 0x7f49a3e37ca0 [Info: 2022-05-01 11:53:00.609515055: XalStorage.cpp(205)] [op 0x7f49a8012794] Xal Write callback - Started [Info: 2022-05-01 11:53:00.610197510: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:53:00.610369174: Xal.lib(0)] XAL: [op 139954327987968] Cleared operation handle 0x7f49a8012794 [Info: 2022-05-01 11:53:00.610502008: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation succeeded [Info: 2022-05-01 11:53:00.610880637: XalStorage.cpp(258)] [op 0x7f49a8012794] Xal Write callback - Succeeded [Info: 2022-05-01 11:53:00.712906492: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation continuing [Info: 2022-05-01 11:53:00.713375900: Xal.lib(0)] XAL: [op 139954328063456] Operation SaveClockSkew succeeded. [Info: 2022-05-01 11:53:00.715234316: Xal.lib(0)] XAL: [op 139954328004320] Operation WriteCacheData is starting [Info: 2022-05-01 11:53:00.715398859: Xal.lib(0)] XAL: [op 139954328004320] with CV 'ULCH2tLsid2XK/h1.19.1' [Info: 2022-05-01 11:53:00.715548722: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation starting [Info: 2022-05-01 11:53:00.715710792: Xal.lib(0)] XAL: [op 139954327987968] Client operation StorageWritePlatformOperation destroyed [Info: 2022-05-01 11:53:00.715867883: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation calling platform handler [Info: 2022-05-01 11:53:00.715983134: Xal.lib(0)] XAL: [op 139954327917152] Added operation as handle 0x7f49a80012f4 with type 0x7f49a3e37ca0 [Info: 2022-05-01 11:53:00.716080342: XalStorage.cpp(205)] [op 0x7f49a80012f4] Xal Write callback - Started [Info: 2022-05-01 11:53:00.892934934: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation platform handler reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:53:00.893157860: Xal.lib(0)] XAL: [op 139954327917152] Cleared operation handle 0x7f49a80012f4 [Info: 2022-05-01 11:53:00.893280611: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation succeeded [Info: 2022-05-01 11:53:00.893596889: XalStorage.cpp(246)] [op 0x7f49a80012f4] Xal Write callback - Succeeded [Info: 2022-05-01 11:53:00.995194927: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation continuing [Info: 2022-05-01 11:53:00.995459253: Xal.lib(0)] XAL: [op 139954328004320] Operation WriteCacheData succeeded. [Info: 2022-05-01 11:53:00.995884205: Xal.lib(0)] XAL: [op 139954327921664] RefreshXtoken token fetch done. [Info: 2022-05-01 11:53:00.995995233: Xal.lib(0)] XAL: [op 139954327921664] Operation RefreshXtoken succeeded. [Info: 2022-05-01 11:53:00.996518744: Xal.lib(0)] XAL: [op 139954328018880] Operation GetXtoken succeeded. [Info: 2022-05-01 11:53:00.996937602: Xal.lib(0)] XAL: [op 139954328022256] Operation GetTokenAndSignature succeeded. [Info: 2022-05-01 11:53:00.997442540: Xal.lib(0)] XAL: [op 139951777792704] Operation StateGetTokenAndSignature succeeded. [Info: 2022-05-01 11:53:00.997994050: Xal.lib(0)] XAL: XalUserGetTokenAndSignatureSilentlyAsync calling back to client with result 'Ok' (0x00000000) [Info: 2022-05-01 11:53:00.998143525: Xal.lib(0)] XAL: [op 139954327917152] Client operation StorageWritePlatformOperation destroyed [Info: 2022-05-01 11:53:00.999245424: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/launcher/login [Info: 2022-05-01 11:53:01.623940415: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:53:01.624516625: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/launcher/login [Info: 2022-05-01 11:53:01.624927738: MinecraftServicesApi.cpp(440)] Signed in to minecraft services with user 3c7c5df5-50ad-4fbe-a6e0-653ad74831ad [Info: 2022-05-01 11:53:01.625109432: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/launcher/login [Info: 2022-05-01 11:53:01.636081939: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:01.997159433: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:53:01.997313575: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:01.997588468: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:02.287340660: UnifiedAccounts.cpp(323)] Internet state in main process: online=1 [Info: 2022-05-01 11:53:02.287754731: Xal.lib(0)] XAL: Generate random bytes platform callback reported completion status 'XalPlatformOperationResult_Success' (0) [Info: 2022-05-01 11:53:02.288666735: NetQueue.cpp(632)] NetQueue: Starting net action https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:02.290418784: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/entitlements/license?requestId=e54f57f4-3953-4c6a-8915-47912807d2ee [Info: 2022-05-01 11:53:02.840974033: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:53:02.841339551: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/entitlements/license?requestId=e54f57f4-3953-4c6a-8915-47912807d2ee [Info: 2022-05-01 11:53:02.841657206: MinecraftServicesApi.cpp(540)] Got entitlements response! [Info: 2022-05-01 11:53:02.846411792: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/entitlements/license?requestId=e54f57f4-3953-4c6a-8915-47912807d2ee [Info: 2022-05-01 11:53:03.149804175: UnifiedMSAAccounts.cpp(510)] Broadcasting change due to new [forced:1] Entitlements for 0680130a26244484904b22209a0246be [Info: 2022-05-01 11:53:03.153904623: Telemetry.cpp(246)] Posting 0 events. [Info: 2022-05-01 11:53:03.193984194: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/events [Info: 2022-05-01 11:53:03.346441535: NetQueue.cpp(472)] NetQueue: Primary ip: 104.212.68.9, Host: launchercontent.mojang.com [Info: 2022-05-01 11:53:03.346613056: NetQueue.cpp(551)] NetQueue: Action finished: https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:03.346757513: NetQueue.cpp(579)] NetQueue: Action finalized: https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:03.347099478: UnifiedAccounts.cpp(703)] Fetched account migration dates from https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:03.347517142: UnifiedAccounts.cpp(343)] Account migration dates: migrationStarts=2021-05-23T00:00:00.000Z forcedMigrationStarts=2022-03-10T18:00:00.000Z forcedMigrationEnds=2099-01-01T00:00:00.000Z [Info: 2022-05-01 11:53:03.348554979: ControllerInterface.cpp(106)] Running method getAccountData [Info: 2022-05-01 11:53:03.348821396: UnifiedAccounts.cpp(323)] Internet state in main process: online=1 [Info: 2022-05-01 11:53:03.351454534: ControllerInterface.cpp(106)] Running method onInternetStateChange [Info: 2022-05-01 11:53:03.736598459: NetQueue.cpp(632)] NetQueue: Starting net action https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:03.847962510: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:53:03.848023687: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/events [Info: 2022-05-01 11:53:03.848174665: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/events [Info: 2022-05-01 11:53:03.848261710: NetQueue.cpp(632)] NetQueue: Starting net action https://launchermeta.mojang.com/mc/game/version_manifest_v2.json?_t=2022-05-01T11:53:03Z [Info: 2022-05-01 11:53:03.935095882: Xal.lib(0)] XAL: [op 139951777793040] Operation UploadTelemetryEvents is starting [Info: 2022-05-01 11:53:03.935148163: Xal.lib(0)] XAL: [op 139951777793040] Operation UploadTelemetryEvents succeeded. [Info: 2022-05-01 11:53:03.935177454: Xal.lib(0)] XAL: [op 139954328064624] Operation UploadTelemetryEventsWithDelay succeeded. [Info: 2022-05-01 11:53:03.945762671: NetQueue.cpp(472)] NetQueue: Primary ip: 104.212.68.9, Host: launchercontent.mojang.com [Info: 2022-05-01 11:53:03.945810519: NetQueue.cpp(551)] NetQueue: Action finished: https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:03.945842587: NetQueue.cpp(579)] NetQueue: Action finalized: https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:03.945919201: UnifiedAccounts.cpp(703)] Fetched account migration dates from https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:03.946007900: UnifiedAccounts.cpp(343)] Account migration dates: migrationStarts=2021-05-23T00:00:00.000Z forcedMigrationStarts=2022-03-10T18:00:00.000Z forcedMigrationEnds=2099-01-01T00:00:00.000Z [Info: 2022-05-01 11:53:03.946039000: UnifiedAccounts.cpp(323)] Internet state in main process: online=1 [Info: 2022-05-01 11:53:03.948645832: NetQueue.cpp(632)] NetQueue: Starting net action https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:04.130339121: NetQueue.cpp(472)] NetQueue: Primary ip: 104.212.68.9, Host: launchercontent.mojang.com [Info: 2022-05-01 11:53:04.130583870: NetQueue.cpp(551)] NetQueue: Action finished: https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:04.130677746: NetQueue.cpp(579)] NetQueue: Action finalized: https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:04.131320991: UnifiedAccounts.cpp(703)] Fetched account migration dates from https://launchercontent.mojang.com/accountMigration.json [Info: 2022-05-01 11:53:04.131623034: UnifiedAccounts.cpp(343)] Account migration dates: migrationStarts=2021-05-23T00:00:00.000Z forcedMigrationStarts=2022-03-10T18:00:00.000Z forcedMigrationEnds=2099-01-01T00:00:00.000Z [Info: 2022-05-01 11:53:04.232052889: NetQueue.cpp(472)] NetQueue: Primary ip: 13.35.8.20, Host: launchermeta.mojang.com [Info: 2022-05-01 11:53:04.232091949: NetQueue.cpp(551)] NetQueue: Action finished: https://launchermeta.mojang.com/mc/game/version_manifest_v2.json?_t=2022-05-01T11:53:03Z [Info: 2022-05-01 11:53:04.232112901: NetQueue.cpp(579)] NetQueue: Action finalized: https://launchermeta.mojang.com/mc/game/version_manifest_v2.json?_t=2022-05-01T11:53:03Z [Info: 2022-05-01 11:53:04.232177971: GameVersionManager.cpp(432)] Got available versions manifest from https://launchermeta.mojang.com/mc/game/version_manifest_v2.json?_t=2022-05-01T11:53:03Z [Info: 2022-05-01 11:53:04.255033499: client_handler.cpp(423)] Handling PostTelemetryEvent message [Info: 2022-05-01 11:53:05.231233234: ControllerInterface.cpp(106)] Running method setStore [Info: 2022-05-01 11:53:08.386335766: client_handler.cpp(423)] Handling PostTelemetryEvent message [Info: 2022-05-01 11:53:08.506082655: LauncherAppBrowser.cpp(83)] Will launch a Chromium subprocess with command line string: /proc/self/exe --type=utility --utility-sub-type=device.mojom.XRDeviceService --lang=zh-CN --service-sandbox-type=utility --no-sandbox --log-severity=info --lang=en-US --user-data-dir=/home/wangze/.config/cef_user_data --launcherui --workdir=/home/wangze/.minecraft [Info: 2022-05-01 11:53:08.609622654: ControllerInterface.cpp(106)] Running method getCapes [Info: 2022-05-01 11:53:08.609989624: ControllerInterface.cpp(106)] Running method getActiveSkin [Info: 2022-05-01 11:53:08.610152628: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:09.061232170: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:53:09.061403068: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:09.061744743: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:09.062850232: NetQueue.cpp(632)] NetQueue: Starting net action http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:53:09.649105104: NetQueue.cpp(472)] NetQueue: Primary ip: 99.86.4.114, Host: textures.minecraft.net [Info: 2022-05-01 11:53:09.649346905: NetQueue.cpp(551)] NetQueue: Action finished: http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:53:09.649464939: NetQueue.cpp(579)] NetQueue: Action finalized: http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:53:09.651221620: NetQueue.cpp(632)] NetQueue: Starting net action http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:53:09.850757195: NetQueue.cpp(472)] NetQueue: Primary ip: 99.86.4.114, Host: textures.minecraft.net [Info: 2022-05-01 11:53:09.851103176: NetQueue.cpp(551)] NetQueue: Action finished: http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:53:09.851257254: NetQueue.cpp(579)] NetQueue: Action finalized: http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:53:09.853504850: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:10.234120511: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:53:10.234203530: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:10.234372166: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:53:10.234895729: NetQueue.cpp(632)] NetQueue: Starting net action http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:53:10.480079346: NetQueue.cpp(472)] NetQueue: Primary ip: 99.86.4.114, Host: textures.minecraft.net [Info: 2022-05-01 11:53:10.480216270: NetQueue.cpp(551)] NetQueue: Action finished: http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:53:10.480348238: NetQueue.cpp(579)] NetQueue: Action finalized: http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:53:10.481558861: NetQueue.cpp(632)] NetQueue: Starting net action http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:53:10.678867371: NetQueue.cpp(472)] NetQueue: Primary ip: 99.86.4.114, Host: textures.minecraft.net [Info: 2022-05-01 11:53:10.679025595: NetQueue.cpp(551)] NetQueue: Action finished: http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:53:10.679114523: NetQueue.cpp(579)] NetQueue: Action finalized: http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Warning: 2022-05-01 11:53:11.281518879: app.dbb69ea1.bundle.js(2)] OnConsoleMessage: THREE.Quaternion: .inverse() has been renamed to invert(). [Info: 2022-05-01 11:53:13.388675734: Telemetry.cpp(246)] Posting 0 events. [Info: 2022-05-01 11:53:13.389668727: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/events [Info: 2022-05-01 11:53:13.831599125: NetQueue.cpp(472)] NetQueue: Primary ip: 52.85.47.52, Host: api.minecraftservices.com [Info: 2022-05-01 11:53:13.831815258: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/events [Info: 2022-05-01 11:53:13.832154856: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/events [Warning: 2022-05-01 11:53:24.815656113: app.dbb69ea1.bundle.js(2)] OnConsoleMessage: THREE.Quaternion: .inverse() has been renamed to invert(). [Info: 2022-05-01 11:54:08.611358816: ControllerInterface.cpp(106)] Running method getCapes [Info: 2022-05-01 11:54:08.611811542: ControllerInterface.cpp(106)] Running method getActiveSkin [Info: 2022-05-01 11:54:44.222287978: NetQueue.cpp(632)] NetQueue: Starting net action https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:54:44.936468159: NetQueue.cpp(472)] NetQueue: Primary ip: 152.199.39.108, Host: piston-meta.mojang.com [Info: 2022-05-01 11:54:44.936636185: NetQueue.cpp(551)] NetQueue: Action finished: https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:54:44.936699953: NetQueue.cpp(579)] NetQueue: Action finalized: https://piston-meta.mojang.com/v1/products/dungeons/f4c685912beb55eb2d5c9e0713fe1195164bba27/windows-x64.json [Info: 2022-05-01 11:54:44.938019882: NetQueue.cpp(632)] NetQueue: Starting net action https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:54:45.100902058: NetQueue.cpp(472)] NetQueue: Primary ip: 152.199.39.108, Host: piston-meta.mojang.com [Info: 2022-05-01 11:54:45.102966648: NetQueue.cpp(551)] NetQueue: Action finished: https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:54:45.103190303: NetQueue.cpp(579)] NetQueue: Action finalized: https://piston-meta.mojang.com/v1/packages/a7c82598c31d7d7a74fd6e5f12a2c119dc51bdf9/manifest.json [Info: 2022-05-01 11:55:00.538659653: ControllerInterface.cpp(106)] Running method reportLatency [Info: 2022-05-01 11:55:00.540615059: ControllerInterface.cpp(106)] Running method reportLatency [Info: 2022-05-01 11:55:08.617275791: ControllerInterface.cpp(106)] Running method getCapes [Info: 2022-05-01 11:55:08.617475250: ControllerInterface.cpp(106)] Running method getActiveSkin [Info: 2022-05-01 11:55:08.618673065: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:55:09.452741456: NetQueue.cpp(472)] NetQueue: Primary ip: 52.84.251.103, Host: api.minecraftservices.com [Info: 2022-05-01 11:55:09.453023222: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:55:09.453982217: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:55:09.455286345: NetQueue.cpp(632)] NetQueue: Starting net action http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:55:10.124977278: NetQueue.cpp(472)] NetQueue: Primary ip: 143.204.47.127, Host: textures.minecraft.net [Info: 2022-05-01 11:55:10.125086710: NetQueue.cpp(551)] NetQueue: Action finished: http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:55:10.125142877: NetQueue.cpp(579)] NetQueue: Action finalized: http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:55:10.125755755: NetQueue.cpp(632)] NetQueue: Starting net action http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:55:10.406540009: NetQueue.cpp(472)] NetQueue: Primary ip: 143.204.47.127, Host: textures.minecraft.net [Info: 2022-05-01 11:55:10.406734895: NetQueue.cpp(551)] NetQueue: Action finished: http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:55:10.406832944: NetQueue.cpp(579)] NetQueue: Action finalized: http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:55:10.411652166: NetQueue.cpp(632)] NetQueue: Starting net action https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:55:10.815343765: NetQueue.cpp(472)] NetQueue: Primary ip: 52.84.251.103, Host: api.minecraftservices.com [Info: 2022-05-01 11:55:10.815543974: NetQueue.cpp(551)] NetQueue: Action finished: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:55:10.815821798: NetQueue.cpp(579)] NetQueue: Action finalized: https://api.minecraftservices.com/minecraft/profile [Info: 2022-05-01 11:55:10.816779397: NetQueue.cpp(632)] NetQueue: Starting net action http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:55:11.041956766: NetQueue.cpp(472)] NetQueue: Primary ip: 143.204.47.127, Host: textures.minecraft.net [Info: 2022-05-01 11:55:11.042039800: NetQueue.cpp(551)] NetQueue: Action finished: http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:55:11.042074696: NetQueue.cpp(579)] NetQueue: Action finalized: http://textures.minecraft.net/texture/c98f360a88e88fa75be1aae12d767056ae2a89f52191885413078c6ae7c0f43f [Info: 2022-05-01 11:55:11.042522388: NetQueue.cpp(632)] NetQueue: Starting net action http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:55:11.263241255: NetQueue.cpp(472)] NetQueue: Primary ip: 143.204.47.127, Host: textures.minecraft.net [Info: 2022-05-01 11:55:11.263398469: NetQueue.cpp(551)] NetQueue: Action finished: http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:55:11.263520273: NetQueue.cpp(579)] NetQueue: Action finalized: http://textures.minecraft.net/texture/2340c0e03dd24a11b15a8b33c2a7e9e32abb2051b2481d0ba7defd635ca7a933 [Info: 2022-05-01 11:56:08.610728801: ControllerInterface.cpp(106)] Running method getCapes [Info: 2022-05-01 11:56:08.611190696: ControllerInterface.cpp(106)] Running method getActiveSkin