Attachment 12554 Details for Bug 45318 – uds.log

uds.log

uds.log (text/x-log), 39.13 KB, created by Alexander Makeenkov on 2023-02-17 17:10:23 MSK

(hide)

Description:

Filename:

MIME Type:

Creator: Alexander Makeenkov

Created: 2023-02-17 17:10:23 MSK

Size: 39.13 KB

patch

obsolete

>DEBUG 2023-02-17 14:51:05,652 opchecker run 291 Checking user service finished 13
>DEBUG 2023-02-17 14:51:05,652 opchecker run 291 Checking user service finished 13
>DEBUG 2023-02-17 14:51:05,677 opchecker run 300 uService instance class: <class 'uds.services.OpenNebula.deployment.LiveDeployment'>
>DEBUG 2023-02-17 14:51:05,677 opchecker run 300 uService instance class: <class 'uds.services.OpenNebula.deployment.LiveDeployment'>
>DEBUG 2023-02-17 14:51:05,689 opchecker checkAndUpdateState 258 Updating uds-vm00012 from In preparation with updater <class 'uds.core.managers.userservice.opchecker.UpdateFromPreparing'> and state W
>DEBUG 2023-02-17 14:51:05,689 opchecker checkAndUpdateState 258 Updating uds-vm00012 from In preparation with updater <class 'uds.core.managers.userservice.opchecker.UpdateFromPreparing'> and state W
>DEBUG 2023-02-17 14:51:05,689 opchecker run 94 Running Executor for uds-vm00012 with state Running and executor <bound method StateUpdater.running of <uds.core.managers.userservice.opchecker.UpdateFromPreparing object at 0x7ff7466863a0>>
>DEBUG 2023-02-17 14:51:05,689 opchecker run 94 Running Executor for uds-vm00012 with state Running and executor <bound method StateUpdater.running of <uds.core.managers.userservice.opchecker.UpdateFromPreparing object at 0x7ff7466863a0>>
>DEBUG 2023-02-17 14:51:05,695 opchecker run 106 Executor for uds-vm00012 done
>DEBUG 2023-02-17 14:51:05,695 opchecker run 106 Executor for uds-vm00012 done
>DEBUG 2023-02-17 14:51:13,706 opchecker run 291 Checking user service finished 13
>DEBUG 2023-02-17 14:51:13,706 opchecker run 291 Checking user service finished 13
>DEBUG 2023-02-17 14:51:13,736 opchecker run 300 uService instance class: <class 'uds.services.OpenNebula.deployment.LiveDeployment'>
>DEBUG 2023-02-17 14:51:13,736 opchecker run 300 uService instance class: <class 'uds.services.OpenNebula.deployment.LiveDeployment'>
>DEBUG 2023-02-17 14:51:13,752 opchecker checkAndUpdateState 258 Updating uds-vm00012 from In preparation with updater <class 'uds.core.managers.userservice.opchecker.UpdateFromPreparing'> and state W
>DEBUG 2023-02-17 14:51:13,752 opchecker checkAndUpdateState 258 Updating uds-vm00012 from In preparation with updater <class 'uds.core.managers.userservice.opchecker.UpdateFromPreparing'> and state W
>DEBUG 2023-02-17 14:51:13,752 opchecker run 94 Running Executor for uds-vm00012 with state Running and executor <bound method StateUpdater.running of <uds.core.managers.userservice.opchecker.UpdateFromPreparing object at 0x7ff72c5ecdf0>>
>DEBUG 2023-02-17 14:51:13,752 opchecker run 94 Running Executor for uds-vm00012 with state Running and executor <bound method StateUpdater.running of <uds.core.managers.userservice.opchecker.UpdateFromPreparing object at 0x7ff72c5ecdf0>>
>DEBUG 2023-02-17 14:51:13,761 opchecker run 106 Executor for uds-vm00012 done
>DEBUG 2023-02-17 14:51:13,761 opchecker run 106 Executor for uds-vm00012 done
>DEBUG 2023-02-17 14:51:17,145 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:17,145 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:17,146 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:17,146 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:17,146 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:17,146 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:17,147 request fillIps 146 Detected proxies: ['10.88.144.250']
>DEBUG 2023-02-17 14:51:17,147 request fillIps 146 Detected proxies: ['10.88.144.250']
>DEBUG 2023-02-17 14:51:17,147 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:17,147 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:17,148 request fillIps 162 ip: 10.88.144.250, ip_proxy: 10.88.144.250
>DEBUG 2023-02-17 14:51:17,148 request fillIps 162 ip: 10.88.144.250, ip_proxy: 10.88.144.250
>DEBUG 2023-02-17 14:51:17,156 request getUser 180 User at Middleware: 1 User user (id:1) from auth internal-db
>DEBUG 2023-02-17 14:51:17,156 request getUser 180 User at Middleware: 1 User user (id:1) from auth internal-db
>DEBUG 2023-02-17 14:51:17,161 services enableService 394 idService: F074e13b8-a40b-5cea-972a-d25c5db67e94, idTransport: fa1d144a-5f22-55c2-a8ed-2abb4bfa61f4
>DEBUG 2023-02-17 14:51:17,161 services enableService 394 idService: F074e13b8-a40b-5cea-972a-d25c5db67e94, idTransport: fa1d144a-5f22-55c2-a8ed-2abb4bfa61f4
>DEBUG 2023-02-17 14:51:17,162 user_service locateUserService 711 Kind of service: F, idService: 074e13b8-a40b-5cea-972a-d25c5db67e94
>DEBUG 2023-02-17 14:51:17,162 user_service locateUserService 711 Kind of service: F, idService: 074e13b8-a40b-5cea-972a-d25c5db67e94
>DEBUG 2023-02-17 14:51:17,167 service_pool validateUser 525 User: 1
>DEBUG 2023-02-17 14:51:17,167 service_pool validateUser 525 User: 1
>DEBUG 2023-02-17 14:51:17,167 service_pool validateUser 526 ServicePool: 1
>DEBUG 2023-02-17 14:51:17,167 service_pool validateUser 526 ServicePool: 1
>DEBUG 2023-02-17 14:51:17,206 user_service getExistingAssignationForUser 387 Found assigned service from Service pool opennebula-pool(1) with 5 as initial, 5 as L1 cache, 0 as L2 cache, 10 as max to user user
>DEBUG 2023-02-17 14:51:17,206 user_service getExistingAssignationForUser 387 Found assigned service from Service pool opennebula-pool(1) with 5 as initial, 5 as L1 cache, 0 as L2 cache, 10 as max to user user
>DEBUG 2023-02-17 14:51:17,211 user_service locateUserService 736 Found service: User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid
>DEBUG 2023-02-17 14:51:17,211 user_service locateUserService 736 Found service: User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid
>DEBUG 2023-02-17 14:51:17,251 request delCurrentRequest 78 Deleting 140453805409856
>DEBUG 2023-02-17 14:51:17,251 request delCurrentRequest 78 Deleting 140453805409856
>DEBUG 2023-02-17 14:51:19,202 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:19,202 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:19,203 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,203 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,203 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,203 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,203 request fillIps 146 Detected proxies: ['10.88.144.250']
>DEBUG 2023-02-17 14:51:19,203 request fillIps 146 Detected proxies: ['10.88.144.250']
>DEBUG 2023-02-17 14:51:19,204 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:19,204 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:19,204 request fillIps 162 ip: 10.88.144.250, ip_proxy: 10.88.144.250
>DEBUG 2023-02-17 14:51:19,204 request fillIps 162 ip: 10.88.144.250, ip_proxy: 10.88.144.250
>DEBUG 2023-02-17 14:51:19,205 request getUser 180 User at Middleware: None None
>DEBUG 2023-02-17 14:51:19,205 request getUser 180 User at Middleware: None None
>DEBUG 2023-02-17 14:51:19,206 __init__ dispatch 118 REST request: client (json)
>DEBUG 2023-02-17 14:51:19,206 __init__ dispatch 118 REST request: client (json)
>DEBUG 2023-02-17 14:51:19,207 handlers __init__ 136 Data: <class 'uds.REST.methods.client.Client'> False False
>DEBUG 2023-02-17 14:51:19,207 handlers __init__ 136 Data: <class 'uds.REST.methods.client.Client'> False False
>DEBUG 2023-02-17 14:51:19,208 client get 112 Client args for GET: ()
>DEBUG 2023-02-17 14:51:19,208 client get 112 Client args for GET: ()
>DEBUG 2023-02-17 14:51:19,209 client result 98 Client Result: {'result': {'availableVersion': '3.5.0', 'requiredVersion': '3.5.0', 'downloadUrl': 'http://10.88.14.214/uds/page/client-download'}}
>DEBUG 2023-02-17 14:51:19,209 client result 98 Client Result: {'result': {'availableVersion': '3.5.0', 'requiredVersion': '3.5.0', 'downloadUrl': 'http://10.88.14.214/uds/page/client-download'}}
>DEBUG 2023-02-17 14:51:19,211 request delCurrentRequest 78 Deleting 140453796755008
>DEBUG 2023-02-17 14:51:19,211 request delCurrentRequest 78 Deleting 140453796755008
>DEBUG 2023-02-17 14:51:19,240 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:19,240 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:19,241 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,241 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,241 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,241 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,242 request fillIps 146 Detected proxies: ['10.88.144.250']
>DEBUG 2023-02-17 14:51:19,242 request fillIps 146 Detected proxies: ['10.88.144.250']
>DEBUG 2023-02-17 14:51:19,242 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:19,242 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:19,242 request fillIps 162 ip: 10.88.144.250, ip_proxy: 10.88.144.250
>DEBUG 2023-02-17 14:51:19,242 request fillIps 162 ip: 10.88.144.250, ip_proxy: 10.88.144.250
>DEBUG 2023-02-17 14:51:19,243 request getUser 180 User at Middleware: None None
>DEBUG 2023-02-17 14:51:19,243 request getUser 180 User at Middleware: None None
>DEBUG 2023-02-17 14:51:19,243 __init__ dispatch 118 REST request: client (json)
>DEBUG 2023-02-17 14:51:19,243 __init__ dispatch 118 REST request: client (json)
>DEBUG 2023-02-17 14:51:19,244 handlers __init__ 136 Data: <class 'uds.REST.methods.client.Client'> False False
>DEBUG 2023-02-17 14:51:19,244 handlers __init__ 136 Data: <class 'uds.REST.methods.client.Client'> False False
>DEBUG 2023-02-17 14:51:19,245 client get 112 Client args for GET: ('vuizssqzdc24lixcmgwmdt3ub4nmw2wwzcs1ynv5', 'xGgpleQ1vgKR7794axtOQD7VHhQ3KmIP')
>DEBUG 2023-02-17 14:51:19,245 client get 112 Client args for GET: ('vuizssqzdc24lixcmgwmdt3ub4nmw2wwzcs1ynv5', 'xGgpleQ1vgKR7794axtOQD7VHhQ3KmIP')
>DEBUG 2023-02-17 14:51:19,246 client get 146 Got Ticket: vuizssqzdc24lixcmgwmdt3ub4nmw2wwzcs1ynv5, scrambled: xGgpleQ1vgKR7794axtOQD7VHhQ3KmIP, Hostname: amakeenk.ipa.basealt.ru, Ip: 10.88.144.250
>DEBUG 2023-02-17 14:51:19,246 client get 146 Got Ticket: vuizssqzdc24lixcmgwmdt3ub4nmw2wwzcs1ynv5, scrambled: xGgpleQ1vgKR7794axtOQD7VHhQ3KmIP, Hostname: amakeenk.ipa.basealt.ru, Ip: 10.88.144.250
>DEBUG 2023-02-17 14:51:19,249 ticket_store get 143 Ticket validity: 2023-02-17 16:52:17 2023-02-17 16:51:19
>DEBUG 2023-02-17 14:51:19,249 ticket_store get 143 Ticket validity: 2023-02-17 16:52:17 2023-02-17 16:51:19
>DEBUG 2023-02-17 14:51:19,304 client get 162 {'service': 'A6fdce3a5-e9d8-5696-a473-b6f7604a568a', 'transport': 'fa1d144a-5f22-55c2-a8ed-2abb4bfa61f4', 'user': '6825ced5-de59-5059-9cd0-af07f29c36df', 'password': b'\xd8\x92\xb0U\x00\xb8b_\xc7\xccy\x88\xe0m+\xb4'}
>DEBUG 2023-02-17 14:51:19,304 client get 162 {'service': 'A6fdce3a5-e9d8-5696-a473-b6f7604a568a', 'transport': 'fa1d144a-5f22-55c2-a8ed-2abb4bfa61f4', 'user': '6825ced5-de59-5059-9cd0-af07f29c36df', 'password': b'\xd8\x92\xb0U\x00\xb8b_\xc7\xccy\x88\xe0m+\xb4'}
>DEBUG 2023-02-17 14:51:19,305 user_service locateUserService 711 Kind of service: A, idService: 6fdce3a5-e9d8-5696-a473-b6f7604a568a
>DEBUG 2023-02-17 14:51:19,305 user_service locateUserService 711 Kind of service: A, idService: 6fdce3a5-e9d8-5696-a473-b6f7604a568a
>DEBUG 2023-02-17 14:51:19,305 user_service locateUserService 715 Getting A service 6fdce3a5-e9d8-5696-a473-b6f7604a568a
>DEBUG 2023-02-17 14:51:19,305 user_service locateUserService 715 Getting A service 6fdce3a5-e9d8-5696-a473-b6f7604a568a
>DEBUG 2023-02-17 14:51:19,313 service_pool validateUser 525 User: 1
>DEBUG 2023-02-17 14:51:19,313 service_pool validateUser 525 User: 1
>DEBUG 2023-02-17 14:51:19,313 service_pool validateUser 526 ServicePool: 1
>DEBUG 2023-02-17 14:51:19,313 service_pool validateUser 526 ServicePool: 1
>DEBUG 2023-02-17 14:51:19,328 user_service locateUserService 736 Found service: User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid
>DEBUG 2023-02-17 14:51:19,328 user_service locateUserService 736 Found service: User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid
>DEBUG 2023-02-17 14:51:19,346 user_service isReady 590 Checking ready of User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid
>DEBUG 2023-02-17 14:51:19,346 user_service isReady 590 Checking ready of User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid
>DEBUG 2023-02-17 14:51:19,352 user_service isReady 596 Service User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid is usable, checking it via setReady
>DEBUG 2023-02-17 14:51:19,352 user_service isReady 596 Service User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid is usable, checking it via setReady
>DEBUG 2023-02-17 14:51:19,411 user_service isReady 604 State: F
>DEBUG 2023-02-17 14:51:19,411 user_service isReady 604 State: F
>DEBUG 2023-02-17 14:51:19,413 log doLog 143 User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid 30000 User user from 10.88.144.250 has initiated access
>DEBUG 2023-02-17 14:51:19,413 log doLog 143 User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid 30000 User user from 10.88.144.250 has initiated access
>DEBUG 2023-02-17 14:51:19,424 user_service getService 834 IP: 10.88.11.70
>DEBUG 2023-02-17 14:51:19,424 user_service getService 834 IP: 10.88.11.70
>DEBUG 2023-02-17 14:51:19,433 connectionpool _new_conn 971 Starting new HTTPS connection (1): 10.88.11.70:43910
>DEBUG 2023-02-17 14:51:19,462 connectionpool _make_request 452 https://10.88.11.70:43910 "GET /actor/G0dLHNEI-3e7diI0UEKHl8uHh60Ju8An5UPmCJbj2mfZ/uuid HTTP/1.1" 200 65
>DEBUG 2023-02-17 14:51:19,464 comms _requestActor 121 Requested uuid to actor. Url=https://10.88.11.70:43910/actor/G0dLHNEI-3e7diI0UEKHl8uHh60Ju8An5UPmCJbj2mfZ/uuid
>DEBUG 2023-02-17 14:51:19,464 comms _requestActor 121 Requested uuid to actor. Url=https://10.88.11.70:43910/actor/G0dLHNEI-3e7diI0UEKHl8uHh60Ju8An5UPmCJbj2mfZ/uuid
>DEBUG 2023-02-17 14:51:19,464 stats addEvent 204 Adding event stat
>DEBUG 2023-02-17 14:51:19,464 stats addEvent 204 Adding event stat
>DEBUG 2023-02-17 14:51:19,487 spice_base isAvailableFor 135 Connection data: {'type': 'SPICE', 'address': 'nebula-node', 'port': 5912, 'secure_port': -1, 'monitors': 1, 'cert_subject': '', 'ticket': {'value': '', 'expiry': ''}}
>DEBUG 2023-02-17 14:51:19,487 spice_base isAvailableFor 135 Connection data: {'type': 'SPICE', 'address': 'nebula-node', 'port': 5912, 'secure_port': -1, 'monitors': 1, 'cert_subject': '', 'ticket': {'value': '', 'expiry': ''}}
>DEBUG 2023-02-17 14:51:19,494 connection testServer 42 Checking connection to nebula-node:5912 with 4 seconds timeout
>DEBUG 2023-02-17 14:51:19,494 connection testServer 42 Checking connection to nebula-node:5912 with 4 seconds timeout
>DEBUG 2023-02-17 14:51:19,500 log doLog 143 User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid 30000 User service ready
>DEBUG 2023-02-17 14:51:19,500 log doLog 143 User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid 30000 User service ready
>DEBUG 2023-02-17 14:51:19,516 connectionpool _new_conn 971 Starting new HTTPS connection (1): 10.88.11.70:43910
>DEBUG 2023-02-17 14:51:19,525 connectionpool _make_request 452 https://10.88.11.70:43910 "POST /actor/G0dLHNEI-3e7diI0UEKHl8uHh60Ju8An5UPmCJbj2mfZ/preConnect HTTP/1.1" 200 31
>DEBUG 2023-02-17 14:51:19,526 comms _requestActor 121 Requested preConnect to actor. Url=https://10.88.11.70:43910/actor/G0dLHNEI-3e7diI0UEKHl8uHh60Ju8An5UPmCJbj2mfZ/preConnect
>DEBUG 2023-02-17 14:51:19,526 comms _requestActor 121 Requested preConnect to actor. Url=https://10.88.11.70:43910/actor/G0dLHNEI-3e7diI0UEKHl8uHh60Ju8An5UPmCJbj2mfZ/preConnect
>DEBUG 2023-02-17 14:51:19,527 client get 177 Res: 10.88.11.70 User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid Base Deployed Service spice-tun of type TSSPICETransport (id:4) Base OS Manager
>DEBUG 2023-02-17 14:51:19,527 client get 177 Res: 10.88.11.70 User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid Base Deployed Service spice-tun of type TSSPICETransport (id:4) Base OS Manager
>DEBUG 2023-02-17 14:51:19,554 transport getEncodedTransportScript 260 Transport script: # This is a template
># Saved as .py for easier editing
>from __future__ import unicode_literals
>
># pylint: disable=import-error, no-name-in-module, undefined-variable
>import subprocess
>
>from uds import tools # type: ignore
>from uds.tunnel import forward # type: ignore
>
>executable = tools.findApp('remote-viewer')
>
>if executable is None:
> raise Exception(
> '''You need to have installed virt-viewer to connect to this UDS service.
>
> Please, install appropriate package for your system.
>
>
> Please, install appropriate package for your Linux system. (probably named something like virt-viewer)
>
>'''
> )
>
>
>theFile = sp['as_file_ns'] # type: ignore
>fs = None
>if sp['ticket']: # type: ignore
> # Open tunnel
> fs = forward(remote=(sp['tunHost'], int(sp['tunPort'])), ticket=sp['ticket'], timeout=sp['tunWait'], check_certificate=sp['tunChk']) # type: ignore
>
> # Check that tunnel works..
> if fs.check() is False:
> raise Exception(
> 'Could not connect to tunnel server.Please, check your network settings.'
> )
>
>fss = None
>if sp['ticket_secure']: # type: ignore
> # Open tunnel
> fss = forward(remote=(sp['tunHost'], int(sp['tunPort'])), ticket=sp['ticket_secure'], timeout=sp['tunWait'], check_certificate=sp['tunChk']) # type: ignore
>
> # Check that tunnel works..
> if fss.check() is False:
> raise Exception(
> 'Could not connect to tunnel server 2.Please, check your network settings.'
> )
>
>theFile = theFile.format(
> secure_port='-1' if not fss else fss.server_address[1],
> port='-1' if not fs else fs.server_address[1],
>)
>
>filename = tools.saveTempFile(theFile)
>subprocess.Popen([executable, filename])
>
>DEBUG 2023-02-17 14:51:19,554 transport getEncodedTransportScript 260 Transport script: # This is a template
># Saved as .py for easier editing
>from __future__ import unicode_literals
>
># pylint: disable=import-error, no-name-in-module, undefined-variable
>import subprocess
>
>from uds import tools # type: ignore
>from uds.tunnel import forward # type: ignore
>
>executable = tools.findApp('remote-viewer')
>
>if executable is None:
> raise Exception(
> '''You need to have installed virt-viewer to connect to this UDS service.
>
> Please, install appropriate package for your system.
>
>
> Please, install appropriate package for your Linux system. (probably named something like virt-viewer)
>
>'''
> )
>
>
>theFile = sp['as_file_ns'] # type: ignore
>fs = None
>if sp['ticket']: # type: ignore
> # Open tunnel
> fs = forward(remote=(sp['tunHost'], int(sp['tunPort'])), ticket=sp['ticket'], timeout=sp['tunWait'], check_certificate=sp['tunChk']) # type: ignore
>
> # Check that tunnel works..
> if fs.check() is False:
> raise Exception(
> 'Could not connect to tunnel server.Please, check your network settings.'
> )
>
>fss = None
>if sp['ticket_secure']: # type: ignore
> # Open tunnel
> fss = forward(remote=(sp['tunHost'], int(sp['tunPort'])), ticket=sp['ticket_secure'], timeout=sp['tunWait'], check_certificate=sp['tunChk']) # type: ignore
>
> # Check that tunnel works..
> if fss.check() is False:
> raise Exception(
> 'Could not connect to tunnel server 2.Please, check your network settings.'
> )
>
>theFile = theFile.format(
> secure_port='-1' if not fss else fss.server_address[1],
> port='-1' if not fs else fs.server_address[1],
>)
>
>filename = tools.saveTempFile(theFile)
>subprocess.Popen([executable, filename])
>
>DEBUG 2023-02-17 14:51:19,555 client get 209 Signature: QXLFvR9cYf0v0SLEBYE8VcY6UMirU/z8htzXU1Qzz89r6hcmsolTyYLuafGNzmcv4qs6qLU4zfXdr4khTzx4utwsSA52dJX5lDs4lN+9p8GCFDKw+Ky4jiE70OaWouwL8ryBmm6RJ/A6pMGPr8DPRWbib27uMm8BR08rSwal0gpbxufGnxs3WS9zm7Ye8AzQ5woSArBl788239yjBqW1L/1ynGdwXUr4NFlE1DOu6v77iO7igbbD9ros8fqKwi1c7q6T8fk6zrDYGZIV3/6d444yuk7zB9mucpz6Uv96fwYr5f62n7hNANRF5M4zdQpNcn1Awf40EAkF+zBUGqGZhAnYQgodYGLKzHflGJ/zDe+0oN0CbTAIW+DqTlijdXHa0iRwE6YjWVAZ/rNvWnYpNPkMX2hRzG9xVPf2GWnUSpl1+lk5DLNmlwSOB+kX6uX9u8W7OI3Xuy7geNGsIsxmDve03h/tTlzWdAPpAcI/ZlcIS0wfnmAVrMxPXuykekewuq9/S2XhUsQy078+dhFbFHNKz9JAhkiR0fiDMSCnbQbtZ4VscPVwkPfa3wwIbauLAv0i5+XHnOnXUc/zqE70af+kyTssx8fDZ6js6m/njsd5zJ/Gn4cKRfLxeVhwPW682q32Gko+4hJA16jPw0mQZHKZb0SXM+4Db0B0968kNY4=
>DEBUG 2023-02-17 14:51:19,555 client get 209 Signature: QXLFvR9cYf0v0SLEBYE8VcY6UMirU/z8htzXU1Qzz89r6hcmsolTyYLuafGNzmcv4qs6qLU4zfXdr4khTzx4utwsSA52dJX5lDs4lN+9p8GCFDKw+Ky4jiE70OaWouwL8ryBmm6RJ/A6pMGPr8DPRWbib27uMm8BR08rSwal0gpbxufGnxs3WS9zm7Ye8AzQ5woSArBl788239yjBqW1L/1ynGdwXUr4NFlE1DOu6v77iO7igbbD9ros8fqKwi1c7q6T8fk6zrDYGZIV3/6d444yuk7zB9mucpz6Uv96fwYr5f62n7hNANRF5M4zdQpNcn1Awf40EAkF+zBUGqGZhAnYQgodYGLKzHflGJ/zDe+0oN0CbTAIW+DqTlijdXHa0iRwE6YjWVAZ/rNvWnYpNPkMX2hRzG9xVPf2GWnUSpl1+lk5DLNmlwSOB+kX6uX9u8W7OI3Xuy7geNGsIsxmDve03h/tTlzWdAPpAcI/ZlcIS0wfnmAVrMxPXuykekewuq9/S2XhUsQy078+dhFbFHNKz9JAhkiR0fiDMSCnbQbtZ4VscPVwkPfa3wwIbauLAv0i5+XHnOnXUc/zqE70af+kyTssx8fDZ6js6m/njsd5zJ/Gn4cKRfLxeVhwPW682q32Gko+4hJA16jPw0mQZHKZb0SXM+4Db0B0968kNY4=
>DEBUG 2023-02-17 14:51:19,555 client get 210 Data:#######
>{'as_file': '[virt-viewer]\ntype=spice\nhost=127.0.0.1\nport={port}\npassword=\ntls-port={secure_port}\nfullscreen=0\ntitle=UDS Enterprise:%d - Press SHIFT+F12 to Release Cursor\nenable-smartcard=0\nenable-usb-autoshare=0\nenable-usbredir=0\ndelete-this-file=1\nusb-filter=-1,-1,-1,-1,0\ntls-ciphers=DEFAULT\nhost-subject=\nca=\ntoggle-fullscreen=shift+f11\nrelease-cursor=shift+f12\nsecure-attention=ctrl+alt+end\n\n', 'as_file_ns': '[virt-viewer]\ntype=spice\nhost=127.0.0.1\nport={port}\npassword=\ntls-port={secure_port}\nfullscreen=0\ntitle=UDS Enterprise:%d - Press SHIFT+F12 to Release Cursor\nenable-smartcard=0\nenable-usb-autoshare=0\nenable-usbredir=0\ndelete-this-file=1\nusb-filter=-1,-1,-1,-1,0\ntls-ciphers=DEFAULT\nhost-subject=\nca=\ntoggle-fullscreen=shift+f11\nrelease-cursor=shift+f12\nsecure-attention=ctrl+alt+end\n\n', 'tunHost': '10.88.14.95', 'tunPort': '7777', 'tunWait': 30, 'tunChk': False, 'ticket': '8guwzzf2nch55atvhigk0zx6eeshqtygvohmn2hqU28fFy3L', 'ticket_secure': '45rg2ymylyxc4n2b3cqnrqkkrj9p5lvb04yuuuwoXmQoTZuz'}
>###########
>DEBUG 2023-02-17 14:51:19,555 client get 210 Data:#######
>{'as_file': '[virt-viewer]\ntype=spice\nhost=127.0.0.1\nport={port}\npassword=\ntls-port={secure_port}\nfullscreen=0\ntitle=UDS Enterprise:%d - Press SHIFT+F12 to Release Cursor\nenable-smartcard=0\nenable-usb-autoshare=0\nenable-usbredir=0\ndelete-this-file=1\nusb-filter=-1,-1,-1,-1,0\ntls-ciphers=DEFAULT\nhost-subject=\nca=\ntoggle-fullscreen=shift+f11\nrelease-cursor=shift+f12\nsecure-attention=ctrl+alt+end\n\n', 'as_file_ns': '[virt-viewer]\ntype=spice\nhost=127.0.0.1\nport={port}\npassword=\ntls-port={secure_port}\nfullscreen=0\ntitle=UDS Enterprise:%d - Press SHIFT+F12 to Release Cursor\nenable-smartcard=0\nenable-usb-autoshare=0\nenable-usbredir=0\ndelete-this-file=1\nusb-filter=-1,-1,-1,-1,0\ntls-ciphers=DEFAULT\nhost-subject=\nca=\ntoggle-fullscreen=shift+f11\nrelease-cursor=shift+f12\nsecure-attention=ctrl+alt+end\n\n', 'tunHost': '10.88.14.95', 'tunPort': '7777', 'tunWait': 30, 'tunChk': False, 'ticket': '8guwzzf2nch55atvhigk0zx6eeshqtygvohmn2hqU28fFy3L', 'ticket_secure': '45rg2ymylyxc4n2b3cqnrqkkrj9p5lvb04yuuuwoXmQoTZuz'}
>###########
>DEBUG 2023-02-17 14:51:19,556 client result 98 Client Result: {'result': {'script': 'QlpoOTFBWSZTWaIRnkAAAKNfgERQSOewFy9Fzqq/79/gUAN+ZsKbsXvblAkoo09EGgNMgAaAAAD1BKRTMCnpNMp6jCYEAGAT0J6CRJpU9GSYjIGjIGmnqAAACPVJqPQ0jIAMmjRoaAGmgNAkSCaRqep6NJmlNqGj1GmhoZGQCaEW+J5uIZc2SL9x4HSY59JUgguvvvulaRM+jqMapBgkkmhEHfqOjuqlql53wDDMaglxImBXFVRGkOdpRAacGXSGyFT3lrW/xIIl+G6I1RWLmsl1wDaSgcVXz8tGVtK4XcmjLJAx7gnOowvEkUpDQdGRUxmMMKwJX8RoG0crXWTMUMFQjSmYzxnYClvX8qRlmYFS/blli+edYOkZ2DJDGmZyIJXGqMeOM5vmcTqJs19sBLOA+AHaaE6LpNcJX7jBFYMjMcgLi5MYzRL8tJ7KGZY8pIsXMoSFQ0MJnfSrJFbkLM0xuYekYHdK/aektSi2lf5Cgt1RxCRL0OTehYCoPT2166HmTTaHlG3w65594uREvotChkesZkBYuSkpIN7yGoH1VLRWftMClyNGXF/oa6s14DNJ2LEExsdZ8JX0OSVCbNAe59DFqClgEEgliPfhcxyoKRFkSKf65I0eUJHwykNll9TKhlxmFhkxlq2ZL6INEzozwoaoGyFEQqWOsslBkUYeRkKDfI2LxN1BW2SWOJrIKkJb/ai9TJ0Z9eFCnJlEW/UlrJqjfLci6MjMKDFuYpHAqNHLsO24YxxEP+hWDDy68Q5rWQX0VDFIYCc9UUQyicYgIl2zNVoVJhJkBMigXOCkSCyGAR2AuzNFmZ0+jB4vsTKKaE6IvEEAxNX0gCsn5iYJCHWbEmIdaQpByTySAU8v7yFTy1GMyK/bjVZEJwNsLvki1SlUPG41lbjaQ1xTOV80uwZCTXPe7Wk3VERfLr7zmUK2Ii6C1s2qkgZvM9xUaozubbNoMywTYzIyXoLOxkmZj1p3DWU3C0m0qmyhwDGqqqwJkGGzNRjFnwGM1EFfcaKQFSoEG1h0TIS6MCCDfeBIaUgyIcDW3Z27VkiFbxksFqJnR/lNbOLoFUsj/i7kinChIUQjPIA=', 'signature': 'QXLFvR9cYf0v0SLEBYE8VcY6UMirU/z8htzXU1Qzz89r6hcmsolTyYLuafGNzmcv4qs6qLU4zfXdr4khTzx4utwsSA52dJX5lDs4lN+9p8GCFDKw+Ky4jiE70OaWouwL8ryBmm6RJ/A6pMGPr8DPRWbib27uMm8BR08rSwal0gpbxufGnxs3WS9zm7Ye8AzQ5woSArBl788239yjBqW1L/1ynGdwXUr4NFlE1DOu6v77iO7igbbD9ros8fqKwi1c7q6T8fk6zrDYGZIV3/6d444yuk7zB9mucpz6Uv96fwYr5f62n7hNANRF5M4zdQpNcn1Awf40EAkF+zBUGqGZhAnYQgodYGLKzHflGJ/zDe+0oN0CbTAIW+DqTlijdXHa0iRwE6YjWVAZ/rNvWnYpNPkMX2hRzG9xVPf2GWnUSpl1+lk5DLNmlwSOB+kX6uX9u8W7OI3Xuy7geNGsIsxmDve03h/tTlzWdAPpAcI/ZlcIS0wfnmAVrMxPXuykekewuq9/S2XhUsQy078+dhFbFHNKz9JAhkiR0fiDMSCnbQbtZ4VscPVwkPfa3wwIbauLAv0i5+XHnOnXUc/zqE70af+kyTssx8fDZ6js6m/njsd5zJ/Gn4cKRfLxeVhwPW682q32Gko+4hJA16jPw0mQZHKZb0SXM+4Db0B0968kNY4=', 'params': 'QlpoOTFBWSZTWXXYhOQAAghfgEAAUg9/8i9kft6////6QAJcAAENUmRmmoaYgYTTTEwgAGmE0wBz\nTEwEaYEYRgAAACYRgc0xMBGmBGEYAAAAmEYBVTSCMmSMmmjJPTFR+lPE0yajI9PRMg9KcWVLBKXy\nT721ieT0VZH22xnvxn3uhFk/KlwiUuFztebAly2xoiWkWNjmSrfVxJoTTTQsQlDQtbIlr16y+24X\nM3QOP/nWrTWSsUIO+HQq8uXhjrxfbL179nrn4aNyFunlpon6zGp+TtTczWm2ITUvVUVqlRqU6Gpq\neKh3v7fRt8Fn0ddqix+IYkL3j4vzxvqsq8NChzq3U50HuwNCbsNaowH4UsLpYZau1el6fDWpdrS5\nFh2PB8YXnDNwf0lS7sjK4J2Jt1Ze50SVN7mMJSrUf7OaEy1BNQmZHKnQg7lUlCXn7Jtq0xJaVx7o\ndCrA8l7Mwnn/nd750QrMaa3sU72HfzZ3Og2Zntbeba8CtgZ5OpKha0KlTjba0/NTkwvDTWzVMCU2\nFHQluKD4F0qnVzfrM46Pd6fG9pQxlSaUNE0yTN0zb1KZLK/e6bTyMhS/fSK2/Me21nWrVDcyP01r\nI2z5FjnJtSbRKaGtgLnI6czbysSuFhiuQXIMqvYqQ41bAlQTRCllrZVjvMWZiKFCxVJUulXVbibi\npUhyJlcIcSteseKZag7EMi1jVkbKlxexl5hlLrXsCCIYyCC1QqAuGLOEEhg5FnRiiNHDKQn2CRoA\ngDF4u5IpwoSDrsQnIA==\n'}}
>DEBUG 2023-02-17 14:51:19,556 client result 98 Client Result: {'result': {'script': 'QlpoOTFBWSZTWaIRnkAAAKNfgERQSOewFy9Fzqq/79/gUAN+ZsKbsXvblAkoo09EGgNMgAaAAAD1BKRTMCnpNMp6jCYEAGAT0J6CRJpU9GSYjIGjIGmnqAAACPVJqPQ0jIAMmjRoaAGmgNAkSCaRqep6NJmlNqGj1GmhoZGQCaEW+J5uIZc2SL9x4HSY59JUgguvvvulaRM+jqMapBgkkmhEHfqOjuqlql53wDDMaglxImBXFVRGkOdpRAacGXSGyFT3lrW/xIIl+G6I1RWLmsl1wDaSgcVXz8tGVtK4XcmjLJAx7gnOowvEkUpDQdGRUxmMMKwJX8RoG0crXWTMUMFQjSmYzxnYClvX8qRlmYFS/blli+edYOkZ2DJDGmZyIJXGqMeOM5vmcTqJs19sBLOA+AHaaE6LpNcJX7jBFYMjMcgLi5MYzRL8tJ7KGZY8pIsXMoSFQ0MJnfSrJFbkLM0xuYekYHdK/aektSi2lf5Cgt1RxCRL0OTehYCoPT2166HmTTaHlG3w65594uREvotChkesZkBYuSkpIN7yGoH1VLRWftMClyNGXF/oa6s14DNJ2LEExsdZ8JX0OSVCbNAe59DFqClgEEgliPfhcxyoKRFkSKf65I0eUJHwykNll9TKhlxmFhkxlq2ZL6INEzozwoaoGyFEQqWOsslBkUYeRkKDfI2LxN1BW2SWOJrIKkJb/ai9TJ0Z9eFCnJlEW/UlrJqjfLci6MjMKDFuYpHAqNHLsO24YxxEP+hWDDy68Q5rWQX0VDFIYCc9UUQyicYgIl2zNVoVJhJkBMigXOCkSCyGAR2AuzNFmZ0+jB4vsTKKaE6IvEEAxNX0gCsn5iYJCHWbEmIdaQpByTySAU8v7yFTy1GMyK/bjVZEJwNsLvki1SlUPG41lbjaQ1xTOV80uwZCTXPe7Wk3VERfLr7zmUK2Ii6C1s2qkgZvM9xUaozubbNoMywTYzIyXoLOxkmZj1p3DWU3C0m0qmyhwDGqqqwJkGGzNRjFnwGM1EFfcaKQFSoEG1h0TIS6MCCDfeBIaUgyIcDW3Z27VkiFbxksFqJnR/lNbOLoFUsj/i7kinChIUQjPIA=', 'signature': 'QXLFvR9cYf0v0SLEBYE8VcY6UMirU/z8htzXU1Qzz89r6hcmsolTyYLuafGNzmcv4qs6qLU4zfXdr4khTzx4utwsSA52dJX5lDs4lN+9p8GCFDKw+Ky4jiE70OaWouwL8ryBmm6RJ/A6pMGPr8DPRWbib27uMm8BR08rSwal0gpbxufGnxs3WS9zm7Ye8AzQ5woSArBl788239yjBqW1L/1ynGdwXUr4NFlE1DOu6v77iO7igbbD9ros8fqKwi1c7q6T8fk6zrDYGZIV3/6d444yuk7zB9mucpz6Uv96fwYr5f62n7hNANRF5M4zdQpNcn1Awf40EAkF+zBUGqGZhAnYQgodYGLKzHflGJ/zDe+0oN0CbTAIW+DqTlijdXHa0iRwE6YjWVAZ/rNvWnYpNPkMX2hRzG9xVPf2GWnUSpl1+lk5DLNmlwSOB+kX6uX9u8W7OI3Xuy7geNGsIsxmDve03h/tTlzWdAPpAcI/ZlcIS0wfnmAVrMxPXuykekewuq9/S2XhUsQy078+dhFbFHNKz9JAhkiR0fiDMSCnbQbtZ4VscPVwkPfa3wwIbauLAv0i5+XHnOnXUc/zqE70af+kyTssx8fDZ6js6m/njsd5zJ/Gn4cKRfLxeVhwPW682q32Gko+4hJA16jPw0mQZHKZb0SXM+4Db0B0968kNY4=', 'params': 'QlpoOTFBWSZTWXXYhOQAAghfgEAAUg9/8i9kft6////6QAJcAAENUmRmmoaYgYTTTEwgAGmE0wBz\nTEwEaYEYRgAAACYRgc0xMBGmBGEYAAAAmEYBVTSCMmSMmmjJPTFR+lPE0yajI9PRMg9KcWVLBKXy\nT721ieT0VZH22xnvxn3uhFk/KlwiUuFztebAly2xoiWkWNjmSrfVxJoTTTQsQlDQtbIlr16y+24X\nM3QOP/nWrTWSsUIO+HQq8uXhjrxfbL179nrn4aNyFunlpon6zGp+TtTczWm2ITUvVUVqlRqU6Gpq\neKh3v7fRt8Fn0ddqix+IYkL3j4vzxvqsq8NChzq3U50HuwNCbsNaowH4UsLpYZau1el6fDWpdrS5\nFh2PB8YXnDNwf0lS7sjK4J2Jt1Ze50SVN7mMJSrUf7OaEy1BNQmZHKnQg7lUlCXn7Jtq0xJaVx7o\ndCrA8l7Mwnn/nd750QrMaa3sU72HfzZ3Og2Zntbeba8CtgZ5OpKha0KlTjba0/NTkwvDTWzVMCU2\nFHQluKD4F0qnVzfrM46Pd6fG9pQxlSaUNE0yTN0zb1KZLK/e6bTyMhS/fSK2/Me21nWrVDcyP01r\nI2z5FjnJtSbRKaGtgLnI6czbysSuFhiuQXIMqvYqQ41bAlQTRCllrZVjvMWZiKFCxVJUulXVbibi\npUhyJlcIcSteseKZag7EMi1jVkbKlxexl5hlLrXsCCIYyCC1QqAuGLOEEhg5FnRiiNHDKQn2CRoA\ngDF4u5IpwoSDrsQnIA==\n'}}
>DEBUG 2023-02-17 14:51:19,561 request delCurrentRequest 78 Deleting 140453805147712
>DEBUG 2023-02-17 14:51:19,561 request delCurrentRequest 78 Deleting 140453805147712
>DEBUG 2023-02-17 14:51:19,853 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:19,853 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:19,853 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,853 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,854 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,854 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,854 request fillIps 146 Detected proxies: ['10.88.14.95']
>DEBUG 2023-02-17 14:51:19,854 request fillIps 146 Detected proxies: ['10.88.14.95']
>DEBUG 2023-02-17 14:51:19,854 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:19,854 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:19,854 request fillIps 162 ip: 10.88.14.95, ip_proxy: 10.88.14.95
>DEBUG 2023-02-17 14:51:19,854 request fillIps 162 ip: 10.88.14.95, ip_proxy: 10.88.14.95
>DEBUG 2023-02-17 14:51:19,854 request getUser 180 User at Middleware: None None
>DEBUG 2023-02-17 14:51:19,854 request getUser 180 User at Middleware: None None
>DEBUG 2023-02-17 14:51:19,855 __init__ dispatch 118 REST request: tunnel/ticket (application/json)
>DEBUG 2023-02-17 14:51:19,855 __init__ dispatch 118 REST request: tunnel/ticket (application/json)
>DEBUG 2023-02-17 14:51:19,855 handlers __init__ 136 Data: <class 'uds.REST.methods.tunnel.TunnelTicket'> False False
>DEBUG 2023-02-17 14:51:19,855 handlers __init__ 136 Data: <class 'uds.REST.methods.tunnel.TunnelTicket'> False False
>DEBUG 2023-02-17 14:51:19,856 tunnel get 64 Tunnel parameters for GET: ('8guwzzf2nch55atvhigk0zx6eeshqtygvohmn2hqU28fFy3L', '10.88.144.250', 'ccece2d777f441739ca29c4f65751c05b43a433ed7e7b530') (<QueryDict: {}>) from 10.88.14.95
>DEBUG 2023-02-17 14:51:19,856 tunnel get 64 Tunnel parameters for GET: ('8guwzzf2nch55atvhigk0zx6eeshqtygvohmn2hqU28fFy3L', '10.88.144.250', 'ccece2d777f441739ca29c4f65751c05b43a433ed7e7b530') (<QueryDict: {}>) from 10.88.14.95
>DEBUG 2023-02-17 14:51:19,858 net ipToLong 64 IP 10.88.14.95 is 173543007
>DEBUG 2023-02-17 14:51:19,858 net ipToLong 64 IP 10.88.14.95 is 173543007
>DEBUG 2023-02-17 14:51:19,858 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,858 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,858 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,858 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:19,861 ticket_store get 143 Ticket validity: 2023-02-17 16:52:49 2023-02-17 16:51:19
>DEBUG 2023-02-17 14:51:19,861 ticket_store get 143 Ticket validity: 2023-02-17 16:52:49 2023-02-17 16:51:19
>DEBUG 2023-02-17 14:51:19,882 net ipToLong 64 IP 10.88.144.250 is 173576442
>DEBUG 2023-02-17 14:51:19,882 net ipToLong 64 IP 10.88.144.250 is 173576442
>DEBUG 2023-02-17 14:51:19,884 stats addEvent 204 Adding event stat
>DEBUG 2023-02-17 14:51:19,884 stats addEvent 204 Adding event stat
>DEBUG 2023-02-17 14:51:19,887 log doLog 143 internal-db of type InternalDBAuth (id:1) 30000 User user started tunnel 8guwzzf2... to 10.88.11.70:5912 from 10.88.144.250.
>DEBUG 2023-02-17 14:51:19,887 log doLog 143 internal-db of type InternalDBAuth (id:1) 30000 User user started tunnel 8guwzzf2... to 10.88.11.70:5912 from 10.88.144.250.
>DEBUG 2023-02-17 14:51:19,894 log doLog 143 User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid 30000 User user started tunnel 8guwzzf2... to 10.88.11.70:5912 from 10.88.144.250.
>DEBUG 2023-02-17 14:51:19,894 log doLog 143 User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid 30000 User user started tunnel 8guwzzf2... to 10.88.11.70:5912 from 10.88.144.250.
>DEBUG 2023-02-17 14:51:19,907 request delCurrentRequest 78 Deleting 140453805409856
>DEBUG 2023-02-17 14:51:19,907 request delCurrentRequest 78 Deleting 140453805409856
>DEBUG 2023-02-17 14:51:21,749 opchecker run 291 Checking user service finished 13
>DEBUG 2023-02-17 14:51:21,749 opchecker run 291 Checking user service finished 13
>DEBUG 2023-02-17 14:51:21,780 opchecker run 300 uService instance class: <class 'uds.services.OpenNebula.deployment.LiveDeployment'>
>DEBUG 2023-02-17 14:51:21,780 opchecker run 300 uService instance class: <class 'uds.services.OpenNebula.deployment.LiveDeployment'>
>DEBUG 2023-02-17 14:51:21,794 opchecker checkAndUpdateState 258 Updating uds-vm00012 from In preparation with updater <class 'uds.core.managers.userservice.opchecker.UpdateFromPreparing'> and state W
>DEBUG 2023-02-17 14:51:21,794 opchecker checkAndUpdateState 258 Updating uds-vm00012 from In preparation with updater <class 'uds.core.managers.userservice.opchecker.UpdateFromPreparing'> and state W
>DEBUG 2023-02-17 14:51:21,795 opchecker run 94 Running Executor for uds-vm00012 with state Running and executor <bound method StateUpdater.running of <uds.core.managers.userservice.opchecker.UpdateFromPreparing object at 0x7ff744611af0>>
>DEBUG 2023-02-17 14:51:21,795 opchecker run 94 Running Executor for uds-vm00012 with state Running and executor <bound method StateUpdater.running of <uds.core.managers.userservice.opchecker.UpdateFromPreparing object at 0x7ff744611af0>>
>DEBUG 2023-02-17 14:51:21,806 opchecker run 106 Executor for uds-vm00012 done
>DEBUG 2023-02-17 14:51:21,806 opchecker run 106 Executor for uds-vm00012 done
>DEBUG 2023-02-17 14:51:22,148 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:22,148 net ipToLong 64 IP 0.0.0.0 is 0
>DEBUG 2023-02-17 14:51:22,148 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:22,148 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:22,148 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:22,148 net networksFromString 109 Getting network from *
>DEBUG 2023-02-17 14:51:22,149 request fillIps 146 Detected proxies: ['10.88.144.250']
>DEBUG 2023-02-17 14:51:22,149 request fillIps 146 Detected proxies: ['10.88.144.250']
>DEBUG 2023-02-17 14:51:22,149 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:22,149 request fillIps 153 Proxies: []
>DEBUG 2023-02-17 14:51:22,149 request fillIps 162 ip: 10.88.144.250, ip_proxy: 10.88.144.250
>DEBUG 2023-02-17 14:51:22,149 request fillIps 162 ip: 10.88.144.250, ip_proxy: 10.88.144.250
>DEBUG 2023-02-17 14:51:22,152 request getUser 180 User at Middleware: 1 User user (id:1) from auth internal-db
>DEBUG 2023-02-17 14:51:22,152 request getUser 180 User at Middleware: 1 User user (id:1) from auth internal-db
>DEBUG 2023-02-17 14:51:22,154 user_service locateUserService 711 Kind of service: F, idService: 074e13b8-a40b-5cea-972a-d25c5db67e94
>DEBUG 2023-02-17 14:51:22,154 user_service locateUserService 711 Kind of service: F, idService: 074e13b8-a40b-5cea-972a-d25c5db67e94
>DEBUG 2023-02-17 14:51:22,156 service_pool validateUser 525 User: 1
>DEBUG 2023-02-17 14:51:22,156 service_pool validateUser 525 User: 1
>DEBUG 2023-02-17 14:51:22,156 service_pool validateUser 526 ServicePool: 1
>DEBUG 2023-02-17 14:51:22,156 service_pool validateUser 526 ServicePool: 1
>DEBUG 2023-02-17 14:51:22,167 user_service getExistingAssignationForUser 387 Found assigned service from Service pool opennebula-pool(1) with 5 as initial, 5 as L1 cache, 0 as L2 cache, 10 as max to user user
>DEBUG 2023-02-17 14:51:22,167 user_service getExistingAssignationForUser 387 Found assigned service from Service pool opennebula-pool(1) with 5 as initial, 5 as L1 cache, 0 as L2 cache, 10 as max to user user
>DEBUG 2023-02-17 14:51:22,169 user_service locateUserService 736 Found service: User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid
>DEBUG 2023-02-17 14:51:22,169 user_service locateUserService 736 Found service: User service opennebula-pool\uds-vm00011, unique_id 02:00:0A:58:08:FC, cache_level 0, user User user (id:1) from auth internal-db, name uds-vm00011, state Valid:Valid
>DEBUG 2023-02-17 14:51:22,189 request delCurrentRequest 78 Deleting 140453796755008
>DEBUG 2023-02-17 14:51:22,189 request delCurrentRequest 78 Deleting 140453796755008
>DEBUG 2023-02-17 14:51:29,791 opchecker run 291 Checking user service finished 13
>DEBUG 2023-02-17 14:51:29,791 opchecker run 291 Checking user service finished 13
>DEBUG 2023-02-17 14:51:29,822 opchecker run 300 uService instance class: <class 'uds.services.OpenNebula.deployment.LiveDeployment'>
>DEBUG 2023-02-17 14:51:29,822 opchecker run 300 uService instance class: <class 'uds.services.OpenNebula.deployment.LiveDeployment'>
>DEBUG 2023-02-17 14:51:29,846 opchecker checkAndUpdateState 258 Updating uds-vm00012 from In preparation with updater <class 'uds.core.managers.userservice.opchecker.UpdateFromPreparing'> and state W
>DEBUG 2023-02-17 14:51:29,846 opchecker checkAndUpdateState 258 Updating uds-vm00012 from In preparation with updater <class 'uds.core.managers.userservice.opchecker.UpdateFromPreparing'> and state W
>DEBUG 2023-02-17 14:51:29,848 opchecker run 94 Running Executor for uds-vm00012 with state Running and executor <bound method StateUpdater.running of <uds.core.managers.userservice.opchecker.UpdateFromPreparing object at 0x7ff7442e2820>>
>DEBUG 2023-02-17 14:51:29,848 opchecker run 94 Running Executor for uds-vm00012 with state Running and executor <bound method StateUpdater.running of <uds.core.managers.userservice.opchecker.UpdateFromPreparing object at 0x7ff7442e2820>>
>DEBUG 2023-02-17 14:51:29,858 opchecker run 106 Executor for uds-vm00012 done
>DEBUG 2023-02-17 14:51:29,858 opchecker run 106 Executor for uds-vm00012 done

Actions: View

Attachments on bug 45318: 12554