Does not work with Proxmox VE version 7.2

[nugzarg]

The drivers does not seems to work wuth Proxmox VE 7.2.
Steps to reproduce:
Run docker-machine command with following parameters:

docker-machine --debug create --driver proxmoxve --proxmoxve-proxmox-host proxmox15.example.com --proxmoxve-proxmox-node proxmox.example.com --proxmoxve-proxmox-user-name root --proxmoxve-proxmox-user-password veryVeryStrong_pass-123 --proxmoxve-proxmox-realm pam --proxmoxve-proxmox-pool kubernetes --proxmoxve-vm-clone-full 2 --proxmoxve-provision-strategy clone --proxmoxve-ssh-username ubuntu --proxmoxve-ssh-password geheim --proxmoxve-vm-clone-vmid 226 --proxmoxve-debug-resty --proxmoxve-debug-driver docker-clone

The stdout of docker-machine command:

Docker Machine Version: 0.16.2, build HEAD
Found binary path at /usr/local/bin/docker-machine-driver-proxmoxve
Launching plugin server for driver proxmoxve
Plugin server listening at address 127.0.0.1:43061
() Calling .GetVersion
Using API Version 1
() Calling .SetConfigRaw
() Calling .GetMachineName
(flag-lookup) Calling .GetMachineName
(flag-lookup) Calling .DriverName
(flag-lookup) Calling .GetCreateFlags
Found binary path at /usr/local/bin/docker-machine-driver-proxmoxve
Launching plugin server for driver proxmoxve
Plugin server listening at address 127.0.0.1:38731
() Calling .GetVersion
Using API Version 1
() Calling .SetConfigRaw
() Calling .GetMachineName
(docker-clone) Calling .GetMachineName
(docker-clone) Calling .DriverName
(docker-clone) Calling .GetCreateFlags
(docker-clone) Calling .SetConfigFromFlags
(docker-clone) {"time":"2022-11-07T16:20:59.776125384+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"95","message":"enabling Resty debugging"}
Reading certificate data from /root/.docker/machine/certs/ca.pem
Decoding PEM data...
Parsing certificate...
Reading certificate data from /root/.docker/machine/certs/cert.pem
Decoding PEM data...
Parsing certificate...
Running pre-create checks...
(docker-clone) Calling .PreCreateCheck
(docker-clone) {"time":"2022-11-07T16:20:59.776361357+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"89","message":"Create called"}
(docker-clone) {"time":"2022-11-07T16:20:59.776369328+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"89","message":"Connecting to proxmox16.example as root@pam with password 'veryVeryStrong_pass-123'"}
(docker-clone) {"time":"2022-11-07T16:21:00.271040299+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"89","message":"Connected to PVE version '7.2-11'"}
(docker-clone) Calling .GetConfigRaw
Creating machine...
(docker-clone) Calling .Create
(docker-clone) {"time":"2022-11-07T16:21:00.273072673+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"95","message":"creating new ssh keypair"}
(docker-clone) {"time":"2022-11-07T16:21:00.484644432+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"89","message":"sleeping 1369 milliseconds before retrieving next ID"}
(docker-clone) {"time":"2022-11-07T16:21:01.853857298+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"95","message":"Retrieving next ID"}
(docker-clone) RESTY 2022/11/07 16:21:01
(docker-clone) ---------------------- REQUEST LOG -----------------------
(docker-clone) GET /api2/json/cluster/nextid HTTP/1.1
(docker-clone) HOST : proxmox15.example:8006
(docker-clone) HEADERS:
(docker-clone) Cookie: PVEAuthCookie=PVE:root@pam:6368F82C::PXUiJUyD3TYhKvC10/ElKunBDwRo4NeJpCCRw14C0vhGz86rhcyXDQBXPOqLMf2kr0K14vO2OkhlRE9FUKnxiJsOK3229RwVQABpAxp+U5Udfe4gTnVLrdYcutSVu1oSYrKCSpJhs2ppmZWcpteqj01cnry0xZlQkRr+5G8VqRGyU+C0udy5Kvxv/fjJCzISkW8/2FfecQmngeoZ6Rc1sdpm+dMkuptm+CKBYZA8gXp4U3I8/6yxvmasf5XXvFatL9O//j0jOAfHnhj5P4bZ5PH24jc44qFpkRKAl/sVFtl55CG2YJnbR8sWorFI0gF9yjOLmfJpYDNdgiLJGkS4hg==
(docker-clone) Csrfpreventiontoken: 6368F82C:5Ib2saPoS3HnxwvboZrLNodvTDOzDDuBltyaf0n2GTk
(docker-clone) User-Agent: go-resty v1.7 - https://github.com/go-resty/resty
(docker-clone) BODY :
(docker-clone) ***** NO CONTENT *****
(docker-clone) ----------------------------------------------------------
(docker-clone) RESTY 2022/11/07 16:21:01
(docker-clone) ---------------------- RESPONSE LOG -----------------------
(docker-clone) STATUS : 200 OK
(docker-clone) RECEIVED AT : 2022-11-07T16:21:01.863114494+04:00
(docker-clone) RESPONSE TIME : 9.005886ms
(docker-clone) HEADERS:
(docker-clone) Cache-Control: max-age=0
(docker-clone) Connection: Keep-Alive
(docker-clone) Content-Length: 14
(docker-clone) Content-Type: application/json;charset=UTF-8
(docker-clone) Date: Mon, 07 Nov 2022 12:21:01 GMT
(docker-clone) Expires: Mon, 07 Nov 2022 12:21:01 GMT
(docker-clone) Pragma: no-cache
(docker-clone) Server: pve-api-daemon/3.0
(docker-clone) BODY :
(docker-clone) {
(docker-clone) "data": "106"
(docker-clone) }
(docker-clone) ----------------------------------------------------------
(docker-clone) {"time":"2022-11-07T16:21:01.863470063+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"89","message":"Next ID is '106'"}
(docker-clone) {"time":"2022-11-07T16:21:01.863540458+04:00","level":"INFO","prefix":"-","file":"proxmoxdriver.go","line":"89","message":"cloning template id '226' as vmid '106'"}
(docker-clone) RESTY 2022/11/07 16:21:01
(docker-clone) ---------------------- REQUEST LOG -----------------------
(docker-clone) POST /api2/json/nodes/proxmox.example.com/qemu/226/clone HTTP/1.1
(docker-clone) HOST : proxmox15.example.com:8006
(docker-clone) HEADERS:
(docker-clone) Content-Type: application/x-www-form-urlencoded
(docker-clone) Cookie: PVEAuthCookie=PVE:root@pam:<SOME_STRING>//<SOME_STRING_2>
(docker-clone) Csrfpreventiontoken: <SOME_STRING>
(docker-clone) User-Agent: go-resty v1.7 - https://github.com/go-resty/resty
(docker-clone) BODY :
(docker-clone) name=docker-clone&newid=106&pool=kubernetes
(docker-clone) ----------------------------------------------------------
(docker-clone) RESTY 2022/11/07 16:21:31
(docker-clone) ---------------------- RESPONSE LOG -----------------------
(docker-clone) STATUS : 595 Connection timed out
(docker-clone) RECEIVED AT : 2022-11-07T16:21:31.911785414+04:00
(docker-clone) RESPONSE TIME : 30.047896419s
(docker-clone) HEADERS:
(docker-clone) Cache-Control: max-age=0
(docker-clone) Date: Mon, 07 Nov 2022 12:21:31 GMT
(docker-clone) Expires: Mon, 07 Nov 2022 12:21:31 GMT
(docker-clone) Pragma: no-cache
(docker-clone) Server: pve-api-daemon/3.0
(docker-clone) BODY :
(docker-clone)
(docker-clone) ----------------------------------------------------------
Error creating machine: Error in driver during machine creation: status code was '595' and error is
595 Connection timed out
notifying bugsnag: [Error creating machine: Error in driver during machine creation: status code was '595' and error is
595 Connection timed out]

[lnxbil]

Can you please look on the PVE side of things and report back how long the clone took? It seems there is a 30 seconds timeout involved somehow.

[nugzarg]

Hello @lnxbil ,

Nothing happens on PVE side during running docker-machine command. The clone task is not starting.

[lnxbil]

That's bad. We need the PVE side of the problem. The driver only sees that it does not respond in time to the POST command. Nothing to do on the driver side if it does not answer.

[tariksimsek]

Hello , Did you able to solve this issue?
Thanks

[lnxbil]

Did you able to solve this issue?

Maybe you can provide more information so that one can actually help you?