2018-10-31 20:58:35,757 dxlclient._cli._crypto - INFO - Saving csr file to /var/lib/MyPythonClient/opendxl-certs/client.csr 2018-10-31 20:58:35,767 dxlclient._cli._crypto - INFO - Saving private key file to /var/lib/MyPythonClient/opendxl-certs/client.key 2018-10-31 20:58:35,777 dxlclient._cli._management_service - DEBUG - Invoking request https://127.0.0.1:8443/remote/DxlBrokerMgmt.generateOpenDXLClientProvisioningPackageCmd with the following parameters: 2018-10-31 20:58:35,777 dxlclient._cli._management_service - DEBUG - {':output': 'json', 'csrString': '-----BEGIN CERTIFICATE REQUEST-----\nMIICmDCCAYACAQAwEjEQMA4GA1UEAwwHc3BpcmVudDCCASIwDQYJKoZIhvcNAQEB\nBQADggEPADCCAQoCggEBALb89tTnZJkeM8KYlctG9sjrhUM9zjzwX+NDbwV44k5G\nM/vuoTQvNUjOLu/ij77WvPZ4SV6RxetdvfevtjnQr7ykrkhNKdxMzywFQnx7Y0dD\nInlaXgGg4094JPFomZSp74Xw5JoJWMujInUccXX/WZedmJO6za9uKS3Km8VFQozw\nX4RaZ8Cc/PYzLntBNUBr32Iriz7DGQd/uCYwSMaTcu0ApTQmYXEGq6VZZLVPuh4I\nGjkJ/ZDdLCow1Hcw3BsLxzR1ALKfjQoaSRoGGqnnJjZ62Wt+nl8U7mW52+RL0EaG\nyq8wdXPGqU36VZwMO86tKJTi0MKVMPqzog0AX4PzpkkCAwEAAaBBMD8GCSqGSIb3\nDQEJDjEyMDAwCQYDVR0TBAIwADAOBgNVHQ8BAf8EBAMCBaAwEwYDVR0lBAwwCgYI\nKwYBBQUHAwIwDQYJKoZIhvcNAQELBQADggEBALAw4Dd3Kk7TXUVsRczO8j13f5t5\ntIW/LqtAURBG3m3J5Mv07/6Wt7/LprL/LRwUWoBW017rv437T7Z36gFF+f418p+K\n0PGD3qYjHAt5ziDofc/U13iqejYhbXoA2iIIOvCA6UeJCBA+vl/dAH7TKZ/igrBZ\nQeDQ1irZWMeC4pSM7TwLTWLVLlnb4uSisyNuiqcroYjCVlTKO/mDqPC2c5X1qIdU\nXLbcaitHpdi8Mx7NYA0Hgxolh+iTl2i9Nd2DZMYHn6Keh1AaIu74pYNsO5WqtmC3\n/7OsELdnJ3/xVg3edu24PJj4HQVZUHNTXj2jFDC9f1WqtlGqYmLygZqSb6Q=\n-----END CERTIFICATE REQUEST-----\n'} 2018-10-31 20:58:35,779 urllib3.connectionpool - DEBUG - Starting new HTTPS connection (1): 127.0.0.1:8443 2018-10-31 20:58:35,856 urllib3.connectionpool - DEBUG - https://127.0.0.1:8443 "GET /remote/DxlBrokerMgmt.generateOpenDXLClientProvisioningPackageCmd?%3Aoutput=json&csrString=-----BEGIN+CERTIFICATE+REQUEST-----%0AMIICmDCCAYACAQAwEjEQMA4GA1UEAwwHc3BpcmVudDCCASIwDQYJKoZIhvcNAQEB%0ABQADggEPADCCAQoCggEBALb89tTnZJkeM8KYlctG9sjrhUM9zjzwX%2BNDbwV44k5G%0AM%2FvuoTQvNUjOLu%2Fij77WvPZ4SV6RxetdvfevtjnQr7ykrkhNKdxMzywFQnx7Y0dD%0AInlaXgGg4094JPFomZSp74Xw5JoJWMujInUccXX%2FWZedmJO6za9uKS3Km8VFQozw%0AX4RaZ8Cc%2FPYzLntBNUBr32Iriz7DGQd%2FuCYwSMaTcu0ApTQmYXEGq6VZZLVPuh4I%0AGjkJ%2FZDdLCow1Hcw3BsLxzR1ALKfjQoaSRoGGqnnJjZ62Wt%2Bnl8U7mW52%2BRL0EaG%0Ayq8wdXPGqU36VZwMO86tKJTi0MKVMPqzog0AX4PzpkkCAwEAAaBBMD8GCSqGSIb3%0ADQEJDjEyMDAwCQYDVR0TBAIwADAOBgNVHQ8BAf8EBAMCBaAwEwYDVR0lBAwwCgYI%0AKwYBBQUHAwIwDQYJKoZIhvcNAQELBQADggEBALAw4Dd3Kk7TXUVsRczO8j13f5t5%0AtIW%2FLqtAURBG3m3J5Mv07%2F6Wt7%2FLprL%2FLRwUWoBW017rv437T7Z36gFF%2Bf418p%2BK%0A0PGD3qYjHAt5ziDofc%2FU13iqejYhbXoA2iIIOvCA6UeJCBA%2Bvl%2FdAH7TKZ%2FigrBZ%0AQeDQ1irZWMeC4pSM7TwLTWLVLlnb4uSisyNuiqcroYjCVlTKO%2FmDqPC2c5X1qIdU%0AXLbcaitHpdi8Mx7NYA0Hgxolh%2BiTl2i9Nd2DZMYHn6Keh1AaIu74pYNsO5WqtmC3%0A%2F7OsELdnJ3%2FxVg3edu24PJj4HQVZUHNTXj2jFDC9f1WqtlGqYmLygZqSb6Q%3D%0A-----END+CERTIFICATE+REQUEST-----%0A HTTP/1.1" 302 0 2018-10-31 20:58:35,860 urllib3.connectionpool - DEBUG - https://127.0.0.1:8443 "GET /login?next=%2Fremote%2FDxlBrokerMgmt.generateOpenDXLClientProvisioningPackageCmd%3F%253Aoutput%3Djson%26csrString%3D-----BEGIN%2BCERTIFICATE%2BREQUEST-----%250AMIICmDCCAYACAQAwEjEQMA4GA1UEAwwHc3BpcmVudDCCASIwDQYJKoZIhvcNAQEB%250ABQADggEPADCCAQoCggEBALb89tTnZJkeM8KYlctG9sjrhUM9zjzwX%252BNDbwV44k5G%250AM%252FvuoTQvNUjOLu%252Fij77WvPZ4SV6RxetdvfevtjnQr7ykrkhNKdxMzywFQnx7Y0dD%250AInlaXgGg4094JPFomZSp74Xw5JoJWMujInUccXX%252FWZedmJO6za9uKS3Km8VFQozw%250AX4RaZ8Cc%252FPYzLntBNUBr32Iriz7DGQd%252FuCYwSMaTcu0ApTQmYXEGq6VZZLVPuh4I%250AGjkJ%252FZDdLCow1Hcw3BsLxzR1ALKfjQoaSRoGGqnnJjZ62Wt%252Bnl8U7mW52%252BRL0EaG%250Ayq8wdXPGqU36VZwMO86tKJTi0MKVMPqzog0AX4PzpkkCAwEAAaBBMD8GCSqGSIb3%250ADQEJDjEyMDAwCQYDVR0TBAIwADAOBgNVHQ8BAf8EBAMCBaAwEwYDVR0lBAwwCgYI%250AKwYBBQUHAwIwDQYJKoZIhvcNAQELBQADggEBALAw4Dd3Kk7TXUVsRczO8j13f5t5%250AtIW%252FLqtAURBG3m3J5Mv07%252F6Wt7%252FLprL%252FLRwUWoBW017rv437T7Z36gFF%252Bf418p%252BK%250A0PGD3qYjHAt5ziDofc%252FU13iqejYhbXoA2iIIOvCA6UeJCBA%252Bvl%252FdAH7TKZ%252FigrBZ%250AQeDQ1irZWMeC4pSM7TwLTWLVLlnb4uSisyNuiqcroYjCVlTKO%252FmDqPC2c5X1qIdU%250AXLbcaitHpdi8Mx7NYA0Hgxolh%252BiTl2i9Nd2DZMYHn6Keh1AaIu74pYNsO5WqtmC3%250A%252F7OsELdnJ3%252FxVg3edu24PJj4HQVZUHNTXj2jFDC9f1WqtlGqYmLygZqSb6Q%253D%250A-----END%2BCERTIFICATE%2BREQUEST-----%250A HTTP/1.1" 302 0 2018-10-31 20:58:36,098 urllib3.connectionpool - DEBUG - https://127.0.0.1:8443 "GET /remote/DxlBrokerMgmt.generateOpenDXLClientProvisioningPackageCmd?%3Aoutput=json&csrString=-----BEGIN+CERTIFICATE+REQUEST-----%0AMIICmDCCAYACAQAwEjEQMA4GA1UEAwwHc3BpcmVudDCCASIwDQYJKoZIhvcNAQEB%0ABQADggEPADCCAQoCggEBALb89tTnZJkeM8KYlctG9sjrhUM9zjzwX%2BNDbwV44k5G%0AM%2FvuoTQvNUjOLu%2Fij77WvPZ4SV6RxetdvfevtjnQr7ykrkhNKdxMzywFQnx7Y0dD%0AInlaXgGg4094JPFomZSp74Xw5JoJWMujInUccXX%2FWZedmJO6za9uKS3Km8VFQozw%0AX4RaZ8Cc%2FPYzLntBNUBr32Iriz7DGQd%2FuCYwSMaTcu0ApTQmYXEGq6VZZLVPuh4I%0AGjkJ%2FZDdLCow1Hcw3BsLxzR1ALKfjQoaSRoGGqnnJjZ62Wt%2Bnl8U7mW52%2BRL0EaG%0Ayq8wdXPGqU36VZwMO86tKJTi0MKVMPqzog0AX4PzpkkCAwEAAaBBMD8GCSqGSIb3%0ADQEJDjEyMDAwCQYDVR0TBAIwADAOBgNVHQ8BAf8EBAMCBaAwEwYDVR0lBAwwCgYI%0AKwYBBQUHAwIwDQYJKoZIhvcNAQELBQADggEBALAw4Dd3Kk7TXUVsRczO8j13f5t5%0AtIW%2FLqtAURBG3m3J5Mv07%2F6Wt7%2FLprL%2FLRwUWoBW017rv437T7Z36gFF%2Bf418p%2BK%0A0PGD3qYjHAt5ziDofc%2FU13iqejYhbXoA2iIIOvCA6UeJCBA%2Bvl%2FdAH7TKZ%2FigrBZ%0AQeDQ1irZWMeC4pSM7TwLTWLVLlnb4uSisyNuiqcroYjCVlTKO%2FmDqPC2c5X1qIdU%0AXLbcaitHpdi8Mx7NYA0Hgxolh%2BiTl2i9Nd2DZMYHn6Keh1AaIu74pYNsO5WqtmC3%0A%2F7OsELdnJ3%2FxVg3edu24PJj4HQVZUHNTXj2jFDC9f1WqtlGqYmLygZqSb6Q%3D%0A-----END+CERTIFICATE+REQUEST-----%0A HTTP/1.1" 200 3561 2018-10-31 20:58:36,098 dxlclient._cli._management_service - DEBUG - Response: OK: "-----BEGIN CERTIFICATE-----\nMIIDETCCAfmgAwIBAgIJAIVeHyt1BUEwMA0GCSqGSIb3DQEBCwUAMD8xPTA7BgNV\nBAMMNE9wZW5EeGxDbGllbnRDQS02ZGNlYWVkMy01NWY3LTQ3OTktODYzMi04MTZj\nMjFlMmIxNTEwHhcNMTgwODIzMjE0NjI0WhcNMjgwODIwMjE0NjI0WjA/MT0wOwYD\nVQQDDDRPcGVuRHhsQnJva2VyQ0EtNmRjZWFlZDMtNTVmNy00Nzk5LTg2MzItODE2\nYzIxZTJiMTUxMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEA07ThS9UP\nqfohFcMGI72+oSViN2CVQHv8Ew3GkBoc1JwZ9hhBzh7+WHCE5DwUK6Dp81lgJ2Uk\nvEcbkLPJUR+fkUaaix1m5SpTYvIBFwBFUuLdt70WZEVDZpwRg4fgf37ohp5KCXs1\nLRqARodzryER7wkvltK4EuQjmzPCU6a1oi+l1Eq4+f0KMWIsV59AQ6ID6nW370zL\nQzK5Fy7mPrJddZzTNmTSRYBqg7SkBODUK1v42SnK0R2t/ZeLBz8/Onc8MWc7/Nkp\ntdvrrxkOI+xf5wLxWV+QQOXh142BTGP7lzJSwXyf43Bf0u3yQaBnCAthbx/40SsU\nhbPs+WTWAn4EXQIDAQABoxAwDjAMBgNVHRMEBTADAQH/MA0GCSqGSIb3DQEBCwUA\nA4IBAQAB7NVCJRMqOG62N4wehArXnR5w5cOf0nBNoxPRAPc2FxNnad904wYRLu7n\npAIqkox4+06CZtxWFeSELeLaIGXhUGfLpD+Wsu1c+ybvrqWKTd19Ontt08hqaGy3\n/rnhQMONB8AbgZeWxiNeH9lfLZczrXSs0Z1HPYwycXYcNIG6bOV3nqii9BDzXJ2F\nAQ0upiO5V2w+ZdekchVSNlJLF2Uic6hayCSxyyXoRGjwC55qJwFbPcKq/A8OXH3K\nhRebA2RFA9To4H3eQr6Ab3DE0aa/I+TxxKlbWPm3iO4NqD+Ti5INh9Y+YjHZmZKx\nWoQhxtk416kn6J+saQINEuXp8t1M\n-----END CERTIFICATE-----\n-----BEGIN CERTIFICATE-----\nMIIDUTCCAjmgAwIBAgIJALcz+DbLIX95MA0GCSqGSIb3DQEBCwUAMD8xPTA7BgNV\nBAMMNE9wZW5EeGxDbGllbnRDQS02ZGNlYWVkMy01NWY3LTQ3OTktODYzMi04MTZj\nMjFlMmIxNTEwHhcNMTgwODIzMjE0NjI0WhcNMjgwODIwMjE0NjI0WjA/MT0wOwYD\nVQQDDDRPcGVuRHhsQ2xpZW50Q0EtNmRjZWFlZDMtNTVmNy00Nzk5LTg2MzItODE2\nYzIxZTJiMTUxMIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEA1MLdfxt1\nmRtZDwZFlSxM8mM0RKQ1RRLFWZkl7ve3O1HdTB1C49q2yMbjVoZ1ptFd9OOx9JYG\nkhrq5VUu27TFzZ41+yZzSSlSHvekUTxcosGNjg8qTpI/ozxRkL/NJwW2GhseC6pC\n5+pZnJff3tHIqJFSmqXLIYxjwDtgUZ1wZsjs7MPsjKnNp5ZVWnlcx8TLMC5gWC1q\ng3MBsdbIsyXfelepV9U2Rb1YZFuXCLK2Nq8ZnZFT9Ta6MhTf8eZhvMb2n6ZhOTD2\nQLRuUBfBl5C+hlwJ2fH2DOGp+//ITqYFebIgaRTyN8aOU5N/vXNkJiLyugKPCBRF\nuI1WnYqlS6BYJwIDAQABo1AwTjAdBgNVHQ4EFgQUdsZnlVUo0JS8ZTLlMjDjUR8d\nPMgwHwYDVR0jBBgwFoAUdsZnlVUo0JS8ZTLlMjDjUR8dPMgwDAYDVR0TBAUwAwEB\n/zANBgkqhkiG9w0BAQsFAAOCAQEAP1gIXS7iuf7pfucqiwK1B6im1ZwyG3Ti3F59\n26A33XFWii6VHvmi0uhz+fVVXwcC9BrQXWCy6QJCHQ/WjGcG7CHO1uoYLA5liP5h\n/z3jwZq07jZXH9fdjLXXNfvs4WPu9WBVhha0mjyMB8YoXTj1G/0Z2HC9qC4CumJW\nGW52EdN+iwZq0XJSl+0r1nvF3xGnZEbXU7kinG0GtrfR7spYZE9UHWutf2JSX+xP\n2TiFjHsMd7CQilcEeZP8EkIhYax7xlyO3g+SaiAkIneHrgG1MdwYcCk6yWkrQkLs\ndI4TtZgkswMJ+/B0LqpAVUJeO09rBtmtksTm3Stu4MK3RMQklA==\n-----END CERTIFICATE-----\n,-----BEGIN CERTIFICATE-----\nMIICzTCCAbUCCQC/Eyb6o2GNJzANBgkqhkiG9w0BAQsFADA/MT0wOwYDVQQDDDRP\ncGVuRHhsQ2xpZW50Q0EtNmRjZWFlZDMtNTVmNy00Nzk5LTg2MzItODE2YzIxZTJi\nMTUxMB4XDTE4MTAzMTIwNTgzNloXDTI4MTAyODIwNTgzNlowEjEQMA4GA1UEAwwH\nc3BpcmVudDCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBALb89tTnZJke\nM8KYlctG9sjrhUM9zjzwX+NDbwV44k5GM/vuoTQvNUjOLu/ij77WvPZ4SV6Rxetd\nvfevtjnQr7ykrkhNKdxMzywFQnx7Y0dDInlaXgGg4094JPFomZSp74Xw5JoJWMuj\nInUccXX/WZedmJO6za9uKS3Km8VFQozwX4RaZ8Cc/PYzLntBNUBr32Iriz7DGQd/\nuCYwSMaTcu0ApTQmYXEGq6VZZLVPuh4IGjkJ/ZDdLCow1Hcw3BsLxzR1ALKfjQoa\nSRoGGqnnJjZ62Wt+nl8U7mW52+RL0EaGyq8wdXPGqU36VZwMO86tKJTi0MKVMPqz\nog0AX4PzpkkCAwEAATANBgkqhkiG9w0BAQsFAAOCAQEAxWaM17uDoc6SAR8E4mkQ\nu2FaUHkddZtQfqAHKI3qOf979bCZ6aJ9xYdExG7NAUs5Kx1WxJm6i+HcvyQ93wj7\nSUswGCbtzNlribDR3qftpVsCCdo8YRnMc78AEbxMMcm1OSxrebsbaCv98+cnmhic\nIFp3oAG0wtFaywNgpKmXf4rTdMprRKZ2AGp/W6pMzBOVpVbzq3Sn72TEx/6Pn0QH\nPGbUiiLXNFRYIvqyXtMMfdtebf8Pi38IFASUds2rC/PENHMYiU7L5pmxFeg6FeH3\nnhcdIhYVfalaE5+S62Jmbw64v80ybl55zhZJs6q0hAUgtQljnrbwwBN2roEhRTFq\n3g==\n-----END CERTIFICATE-----\n,local=local;8883;localhost;127.0.0.1\nexternal=external;8883;127.0.0.1;127.0.0.1\ndocker=docker;8883;10.141.0.1;10.141.0.1\n" 2018-10-31 20:58:36,099 dxlclient._cli._cli_subcommands - INFO - Saving DXL config file to /var/lib/MyPythonClient/opendxl-certs/dxlclient.config 2018-10-31 20:58:36,100 dxlclient._cli._cli_subcommands - INFO - Saving ca bundle file to /var/lib/MyPythonClient/opendxl-certs/ca-bundle.crt 2018-10-31 20:58:36,100 dxlclient._cli._cli_subcommands - INFO - Saving client certificate file to /var/lib/MyPythonClient/opendxl-certs/client.crt 2018-10-31 20:58:36,102 dxlclient.client - DEBUG - subscribe(): Waiting for Subscriptions lock... 2018-10-31 20:58:36,102 dxlclient.client - DEBUG - subscribe(): Releasing Subscriptions lock. 2018-10-31 20:58:36,102 dxlclient.client - INFO - Waiting for broker list... 2018-10-31 20:58:36,102 dxlclient.client - DEBUG - Checking brokers... 2018-10-31 20:58:36,103 dxlclient.client - INFO - Trying to connect... 2018-10-31 20:58:36,103 dxlclient.client - INFO - Trying to connect to broker {Unique id: {b45e05b7-b13c-4669-ab8f-0a58a58080d7}, Host name: 127.0.0.1, Port: 8883}... 2018-10-31 20:58:36,108 dxlclient.client - DEBUG - MQTT: Sending CONNECT (u0, p0, wr0, wq0, wf0, c1, k1800) client_id={e12ec4f8-d42c-447e-a2e9-654c8976e9cb} 2018-10-31 20:58:36,108 dxlclient.client - INFO - Connected to broker {b45e05b7-b13c-4669-ab8f-0a58a58080d7} 2018-10-31 20:58:36,108 dxlclient.client - DEBUG - Launching event loop... 2018-10-31 20:58:36,109 dxlclient.client - DEBUG - MQTT: Received CONNACK (0, 0) 2018-10-31 20:58:36,109 dxlclient.client - DEBUG - Connected with result code 0 2018-10-31 20:58:36,109 dxlclient.client - DEBUG - Subscribing to /mcafee/client/{e12ec4f8-d42c-447e-a2e9-654c8976e9cb} 2018-10-31 20:58:36,109 dxlclient.client - DEBUG - MQTT: Sending SUBSCRIBE (d0, m1) [('/mcafee/client/{e12ec4f8-d42c-447e-a2e9-654c8976e9cb}', 0)] 2018-10-31 20:58:36,110 dxlclient.client - DEBUG - MQTT: Received SUBACK 2018-10-31 20:58:36,410 root - INFO - Received socked connection from [('127.0.0.1', 51470)] 2018-10-31 20:58:36,410 root - INFO - Received an empty mesage, breaking the infinite loop to close the connection. 2018-10-31 20:58:36,410 root - INFO - Finished this connection, socket will be closed. 2018-10-31 20:58:36,410 root - INFO - Close current socket 2018-10-31 20:58:36,412 root - INFO - Received socked connection from [('127.0.0.1', 51471)] 2018-10-31 21:00:30,541 dxlclient.client - DEBUG - subscribe(): Waiting for Subscriptions lock... 2018-10-31 21:00:30,541 dxlclient.client - DEBUG - MQTT: Sending SUBSCRIBE (d0, m2) [('TOS/127.0.1.1/7d0bc52b-7586-4141-b1d5-2124bcd0cd86/MyService1', 0)] 2018-10-31 21:00:30,542 dxlclient.client - DEBUG - MQTT: Received SUBACK 2018-10-31 21:00:30,542 dxlclient.client - DEBUG - subscribe(): Releasing Subscriptions lock. 2018-10-31 21:00:30,545 dxlclient.client - DEBUG - MQTT: Sending PUBLISH (d0, q0, r0, m3), '/mcafee/service/dxl/svcregistry/register', ... (392 bytes) 2018-10-31 21:00:30,548 dxlclient.client - DEBUG - MQTT: Received PUBLISH (d0, q0, r0, m0), '/mcafee/client/{e12ec4f8-d42c-447e-a2e9-654c8976e9cb}', ... (247 bytes) 2018-10-31 21:00:30,548 dxlclient.client - DEBUG - Message received for topic /mcafee/client/{e12ec4f8-d42c-447e-a2e9-654c8976e9cb} 2018-10-31 21:00:30,613 dxlclient.client - DEBUG - subscribe(): Waiting for Subscriptions lock... 2018-10-31 21:00:30,613 dxlclient.client - DEBUG - MQTT: Sending SUBSCRIBE (d0, m4) [('TOS/127.0.1.1/7d0bc52b-7586-4141-b1d5-2124bcd0cd86/MyService2', 0)] 2018-10-31 21:00:30,614 dxlclient.client - DEBUG - MQTT: Received SUBACK