search

crossbario / crossbar

Crossbar.io - WAMP application router
https://crossbar.io/
Other
2.05k stars 274 forks source link

'FrontendProxyProtocol' object has no attribute 'write' #1719

Closed om26er closed 4 years ago

om26er commented 4 years ago

That happens when a proxy worker is run over TLS

  File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 1235, in consumeData

  File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 2833, in processHandshake

  File ".tox/buildexe/lib/python3.7/site-packages/txaio/tx.py", line 443, in add_callbacks

  File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py", line 311, in addCallbacks

--- <exception caught here> ---
  File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py", line 654, in _runCallbacks

  File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 2985, in succeedHandshake

  File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 1329, in sendData

  File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/_newtls.py", line 189, in write

builtins.AttributeError: 'FrontendProxyProtocol' object has no attribute 'write'
meejah commented 4 years ago

This is for TLS between the router and worker, right?

oberstet commented 4 years ago

^ not sure actually, could be fpr the incoming TLS - @om26er ^ ?

om26er commented 4 years ago

@meejah Its likely about TLS between router and worker, since the issue appears while Crossbar is starting. I have now attached the latest (and complete) log.

Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] 
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]     :::::::::::::::::
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]           :::::          _____                 __              _____  __
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]     :::::   :   :::::   / ___/______  ___ ___ / /  ___ _____  / __/ |/_/
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]     :::::::   :::::::  / /__/ __/ _ \(_-<(_-</ _ \/ _ `/ __/ / _/_>  <
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]     :::::   :   :::::  \___/_/  \___/___/___/_.__/\_,_/_/   /_/ /_/|_|
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]           :::::
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]     :::::::::::::::::   Crossbar Fabric XBR v20.2.2 [20200225-102dd51]
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] 
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]     Copyright (c) 2013-2020 Crossbar.io Technologies GmbH. All rights reserved.
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Initializing <crossbarfx.edge.node.node.FabricNode> as node [realm=crossbar, cbdir=/node/.crossbar]
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Node key files exist and are valid. Node public key is 0x5f943a9733d3ab2b01a9c9190110fa2932024093e6e91a8d905310fa8a96a4d3
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Node key loaded from /node/.crossbar/key.priv
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Built-in default node configuration loaded from /tmp/_MEIoQEwwN/crossbarfx/edge/node/config/pairme.json
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Node configuration loaded [config_source=localfile, config_path=/node/.crossbar/config.json]
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Entering event reactor ...
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Starting edge node <crossbar.node.node.Node.start>
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Node ID demo.eu-central-1.crossbar.io-2418 set from hostname/pid
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] RouterFactory.start_realm: router created for realm "crossbar"
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Router.attach(session=7524697099496274)
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Router.attach(session=7524697099496274): attached session 7524697099496274 to router realm "crossbar"
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] RouterServiceAgent: realm service session attached (details=
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: SessionDetails(realm=<crossbar>,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                session=7524697099496274,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                authid=<nodecontroller-serviceagent>,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                authrole=<trusted>,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                authmethod=None,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                authprovider=None,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                authextra=None,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                serializer=<None>,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                resumed=None,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                resumable=None,
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]:                resume_token=None))
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] RouterServiceAgent: realm service session ready (realm_name="crossbar", on_ready=None)
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Docker daemon integration disabled!
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Router.attach(session=6438563350318883)
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Router.attach(session=6438563350318883): attached session 6438563350318883 to router realm "crossbar"
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Joined realm 'crossbar' on node management router
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Registered 49 management procedures on realm "crossbar"
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.backlog_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.create_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.delete_docker_image
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.destroy_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.fs_docker_get
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.fs_docker_open
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.fs_docker_put
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_cpu_affinity
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_cpu_count
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_cpus
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_docker_containers
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_docker_df
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_docker_image
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_docker_images
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_docker_info
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_docker_ping
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_docker_version
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_manhole
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_process_info
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_process_monitor
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_process_stats
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_status
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_system_stats
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_worker
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_worker_log
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.get_workers
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.keystroke_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.pause_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.prune_docker_images
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.remove_docker_image
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.request_docker_tty
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.restart_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.set_cpu_affinity
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.set_process_stats_monitoring
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.shell_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.shutdown
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.start_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.start_manhole
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.start_worker
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.started
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.stop_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.stop_manhole
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.stop_worker
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.trigger_gc
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.unpause_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.uptime
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.utcnow
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418]   crossbar.watch_docker_container
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Signal handler installed on process 2418 thread 140589795194688
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Router.attach(session=5693508181910914)
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Router.attach(session=5693508181910914): attached session 5693508181910914 to router realm "crossbar"
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Using default node shutdown triggers ['shutdown_on_shutdown_requested']
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Booting node <crossbarfx.edge.node.node.FabricNode.boot>
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] No CrossbarFX management uplink configured (running unmanaged/single-node)
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Booting node from local configuration [parallel_worker_start=False] .. <crossbar.node.node.Node.boot_from_config>
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Will start 3 workers ..
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Order node to start "Router worker001" ..
Mar 02 20:14:12 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:12+0000 [Controller   2418] Starting router worker worker001 <crossbar.node.controller.NodeController.start_worker>
Mar 02 20:14:13 demo.eu-central-1.crossbar.io docker[4029]: [1B blob data]
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Starting worker "worker001" for node "demo.eu-central-1.crossbar.io-2418" on realm "crossbar" with personality "edge" <crossbarfx.edge.worker.router.ExtRouterController>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Running as PID 2423 on CPython-EPollReactor
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Entering event reactor ...
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Router.attach(session=3200911032378761)
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Router.attach(session=3200911032378761): attached session 3200911032378761 to router realm "crossbar"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] WAMP session statistics DISABLED
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Router worker session for "worker001" joined realm "crossbar" on node router <crossbar.worker.router.RouterController.onJoin>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Registered 56 management procedures on realm "crossbar"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.add_pythonpath
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_cpu_affinity
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_cpu_count
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_cpus
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_manhole
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_node_id
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_process_info
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_process_monitor
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_process_stats
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_profile
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_profilers
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_pythonpath
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_component
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_components
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_realm
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_realm_interface
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_realm_link
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_realm_links
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_realm_role
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_realm_roles
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_realm_stats
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_realms
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_transport
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_router_transports
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_trace
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_trace_data
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_traces
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.get_web_transport_service
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.kill_by_authid
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.set_cpu_affinity
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.set_node_id
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.set_process_stats_monitoring
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.shutdown
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_manhole
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_profiler
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_router_component
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_router_realm
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_router_realm_interface
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_router_realm_link
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_router_realm_role
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_router_transport
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_trace
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.start_web_transport_service
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.started
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_manhole
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_router_component
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_router_realm
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_router_realm_interface
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_router_realm_link
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_router_realm_role
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_router_transport
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_trace
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.stop_web_transport_service
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.trigger_gc
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.uptime
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422]   crossbar.worker.worker001.utcnow
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Router worker session for "worker001" ready
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Ok, node has started Router worker001
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Configuring Router worker001 ..
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Order Router worker001 to start Realm io.crossbar.demo
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Starting router realm "io.crossbar.demo" <crossbarfx.edge.worker.router.ExtRouterController.start_router_realm>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Starting router realm io.crossbar.demo <crossbar.worker.router.RouterController.start_router_realm>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Initialized realm store <class 'crossbar.router.realmstore.MemoryRealmStore'> for realm "crossbardemo"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] RouterFactory.start_realm: router created for realm "crossbardemo"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Router.attach(session=452080721362082)
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Router.attach(session=452080721362082): attached session 452080721362082 to router realm "crossbardemo"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] RouterServiceAgent: realm service session attached (details=
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: SessionDetails(realm=<crossbardemo>,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                session=452080721362082,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authid=<routerworker-worker001-realm-io.crossbar.demo-serviceagent>,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authrole=<trusted>,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authmethod=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authprovider=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authextra=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                serializer=<None>,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                resumed=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                resumable=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                resume_token=None))
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] RouterServiceAgent: realm service session ready (realm_name="crossbardemo", on_ready=<Deferred at 0x7fe419d4c390>)
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] RouterServiceAgent started on realm "crossbardemo"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Realm "io.crossbar.demo" (name="crossbardemo") started
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Ok, Router worker001 has started Realm io.crossbar.demo
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Order Realm io.crossbar.demo to start Role role001
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Starting role "role001" on realm "io.crossbar.demo" <crossbar.worker.router.RouterController.start_router_realm_role>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] role role001 on realm io.crossbar.demo started
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Ok, Realm io.crossbar.demo has started Role role001
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Order Router worker001 to start Realm io.crossbar.iotcookbook
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Starting router realm "io.crossbar.iotcookbook" <crossbarfx.edge.worker.router.ExtRouterController.start_router_realm>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Starting router realm io.crossbar.iotcookbook <crossbar.worker.router.RouterController.start_router_realm>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] RouterFactory.start_realm: router created for realm "iot_cookbook"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Router.attach(session=5559198325515534)
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Router.attach(session=5559198325515534): attached session 5559198325515534 to router realm "iot_cookbook"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] RouterServiceAgent: realm service session attached (details=
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: SessionDetails(realm=<iot_cookbook>,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                session=5559198325515534,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authid=<routerworker-worker001-realm-io.crossbar.iotcookbook-serviceagent>,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authrole=<trusted>,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authmethod=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authprovider=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                authextra=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                serializer=<None>,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                resumed=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                resumable=None,
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]:                resume_token=None))
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] RouterServiceAgent: realm service session ready (realm_name="iot_cookbook", on_ready=<Deferred at 0x7fe419893860>)
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] RouterServiceAgent started on realm "iot_cookbook"
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Realm "io.crossbar.iotcookbook" (name="iot_cookbook") started
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Ok, Router worker001 has started Realm io.crossbar.iotcookbook
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Order Realm io.crossbar.iotcookbook to start Role role002
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Starting role "role002" on realm "io.crossbar.iotcookbook" <crossbar.worker.router.RouterController.start_router_realm_role>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] role role002 on realm io.crossbar.iotcookbook started
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Ok, Realm io.crossbar.iotcookbook has started Role role002
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Order Router worker001 to start Transport transport001
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Starting router transport "transport001" <crossbar.worker.router.RouterController.start_router_transport>
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Creating router transport for "transport001" ..
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] Router transport created for "transport001" [transport_class=<crossbar.worker.transport.RouterTransport>]
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Router       2422] WampWebSocketServerFactory starting on '/node/.crossbar/router.sock'
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Ok, Router worker001 has started Transport transport001
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Ok, Router worker001 configured
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Order node to start "Proxy worker002" ..
Mar 02 20:14:15 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:15+0000 [Controller   2418] Starting proxy worker worker002 <crossbar.node.controller.NodeController.start_worker>
Mar 02 20:14:16 demo.eu-central-1.crossbar.io docker[4029]: [1B blob data]
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting worker "worker002" for node "demo.eu-central-1.crossbar.io-2418" on realm "crossbar" with personality "edge" <crossbar.worker.proxy.ProxyController>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Running as PID 2428 on CPython-EPollReactor
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Entering event reactor ...
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Router.attach(session=8935225597186462)
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Router.attach(session=8935225597186462): attached session 8935225597186462 to router realm "crossbar"
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] WAMP session statistics DISABLED
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Proxy worker "worker002" session 8935225597186462 initializing ..
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Registered 51 management procedures on realm "crossbar"
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.add_pythonpath
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_cpu_affinity
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_cpu_count
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_cpus
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_manhole
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_node_id
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_process_info
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_process_monitor
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_process_stats
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_profile
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_profilers
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_pythonpath
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_component
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_components
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_realm
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_realm_link
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_realm_links
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_realm_role
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_realm_roles
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_realm_stats
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_realms
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_transport
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_router_transports
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.get_web_transport_service
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.kill_by_authid
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.set_cpu_affinity
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.set_node_id
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.set_process_stats_monitoring
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.shutdown
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_manhole
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_profiler
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_proxy_backend
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_proxy_transport
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_router_component
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_router_realm
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_router_realm_link
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_router_realm_role
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_router_transport
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.start_web_transport_service
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.started
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.stop_manhole
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.stop_proxy_transport
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.stop_router_component
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.stop_router_realm
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.stop_router_realm_link
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.stop_router_realm_role
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.stop_router_transport
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.stop_web_transport_service
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.trigger_gc
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.uptime
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427]   crossbar.worker.worker002.utcnow
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Ok, node has started Proxy worker002
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Configuring Proxy worker002 ..
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Order Proxy worker002 to start Transport transport000
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] start_proxy_transport: transport_id=transport000, config={'type': 'web', 'endpoint': {'type': 'tcp', 'port': 80, 'shared': True, 'backlog': 1024}, 'paths': {'/': {'type': 'redirect', 'url': 'https://demo.crossbar.io'}}, 'id': 'transport000'}
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting router transport "transport000" <crossbar.worker.router.RouterController.start_router_transport>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Creating router transport for "transport000" ..
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Router transport created for "transport000" [transport_class=<crossbar.worker.transport.RouterWebTransport>]
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Created "redirect" Web service on root path "/" of Web transport "transport000"
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Site starting on 80
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "redirect" Web service on path "/" of transport "transport000" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Ok, Proxy worker002 has started Transport transport000
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Order Proxy worker002 to start Transport transport001
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] start_proxy_transport: transport_id=transport001, config={'type': 'web', 'endpoint': {'type': 'tcp', 'port': 443, 'shared': True, 'backlog': 1024, 'tls': {'key': 'server.key', 'certificate': 'server.crt', 'ciphers': 'ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES-128-SHA256:ECDHE-RSA-AES-256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES-128-CBC-SHA:DHE-RSA-AES-256-CBC-SHA:AES-128-CBC-SHA:AES-256-CBC-SHA', 'dhparam': 'dhparam.pem', 'chain_certificates': ['intermediate.crt']}}, 'paths': {'/': {'type': 'static', 'directory': 'git/crossbar-examples/demos/_demo_launcher/web'}, 'shared': {'type': 'static', 'directory': 'git/crossbar-examples/_shared-web-resources'}, 'info': {'type': 'nodeinfo'}, 'starterkit': {'type': 'static', 'directory': 'git/iotcookbook/device/pi/components'}, 'wpadlab': {'type': 'static', 'directory': 'git/crossbar-examples/iotcookbook/app/weights/wpadlab/web'}, 'wpadeuro': {'type': 'static', 'directory': 'git/crossbar-examples/iotcookbook/app/weights/wpadeuro'}, 'beatbox': {'type': 'static', 'directory': 'git/crossbar-examples/demos/beatbox'}, 'chat': {'type': 'static', 'directory': 'git/crossbar-examples/demos/chat'}, 'colorpicker': {'type': 'static', 'directory': 'git/crossbar-examples/demos/colorpicker'}, 'colorama': {'type': 'static', 'directory': 'git/crossbar-examples/demos/colorama'}, 'gauges': {'type': 'static', 'directory': 'git/crossbar-examples/demos/gauges'}, 'notification': {'type': 'static', 'directory': 'git/crossbar-examples/demos/notification'}, 'pubsub': {'type': 'static', 'directory': 'git/crossbar-examples/demos/pubsub'}, 'sliders': {'type': 'static', 'directory': 'git/crossbar-examples/demos/sliders'}, 'visitors_counter': {'type': 'static', 'directory': 'git/crossbar-examples/demos/visitors_counter'}, 'dashboard': {'type': 'static', 'directory': 'git/crossbar-examples/demos/dashboard/board'}, 'dashboardcontroller': {'type': 'static', 'directory': 'git/crossbar-examples/demos/dashboard/controller'}, 'videocontrol': {'type': 'static', 'directory': 'git/crossbar-examples/demos/videocontrol/web'}, 'spreadsheet': {'type': 'static', 'directory': 'git/crossbar-examples/demos/spread'}, 'widget': {'type': 'static', 'directory': 'git/crossbar-examples/demos/widget'}, 'dispenser': {'type': 'static', 'directory': 'git/crossbar-examples/iotcookbook/app/dispenser/frontend'}, 'smart-replenishment': {'type': 'static', 'directory': 'git/crossbario-projects/smart-replenishment/gastrocool/web', 'options': {'enable_directory_listing': True, 'mime_types': {'png': 'image/png', 'svg': 'image/svg+xml'}}}, 'prodisys': {'type': 'static', 'directory': 'git/project-prodisys/test/web'}, 'ws': {'type': 'websocket-proxy', 'serializers': ['cbor', 'msgpack', 'json'], 'backends': [{'type': 'websocket', 'endpoint': {'type': 'unix', 'path': 'router.sock'}, 'url': 'ws://localhost', 'serializers': ['json']}], 'options': {'allowed_origins': ['*'], 'allow_null_origin': True, 'enable_webstatus': True, 'max_frame_size': 1048576, 'max_message_size': 1048576, 'auto_fragment_size': 65536, 'fail_by_drop': True, 'open_handshake_timeout': 2500, 'close_handshake_timeout': 1000, 'auto_ping_interval': 10000, 'auto_ping_timeout': 5000, 'auto_ping_size': 4, 'compression': {'deflate': {'request_no_context_takeover': False, 'request_max_window_bits': 13, 'no_context_takeover': False, 'max_window_bits': 13, 'memory_level': 5}}}}}, 'id': 'transport001'}
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting router transport "transport001" <crossbar.worker.router.RouterController.start_router_transport>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Creating router transport for "transport001" ..
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Router transport created for "transport001" [transport_class=<crossbar.worker.transport.RouterWebTransport>]
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Created "static" Web service on root path "/" of Web transport "transport001"
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Loading server TLS key from /node/.crossbar/server.key
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Loading server TLS certificate from /node/.crossbar/server.crt
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Loading server TLS chain certificate from /node/.crossbar/intermediate.crt
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Using explicit TLS ciphers from config
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Site (TLS) starting on 443
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "/" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "shared" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "nodeinfo" Web service on path "info" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Unable to format event {'cb_namespace': 'FD1', 'log_system': 'Proxy        2427', 'log_logger': <Logger 'crossbar.worker.proxy.ProxyWorkerProcess'>, 'log_level': <LogLevel=info>, 'log_namespace': 'crossbar.worker.proxy.ProxyWorkerProcess', 'log_source': None, 'log_format': 'b\'Starting worker "worker002" for node "demo.eu-central-1.crossbar.io-2418" on realm "crossbar" with personality "edge" <crossbar.worker.proxy.ProxyController>\\nRunning as PID 2428 on CPython-EPollReactor\\nEntering event reactor ...\\nProxy worker "worker002" session 8935225597186462 initializing ..\\nRegistered 51 management procedures on realm "crossbar"\\n  crossbar.worker.worker002.add_pythonpath\\n  crossbar.worker.worker002.get_cpu_affinity\\n  crossbar.worker.worker002.get_cpu_count\\n  crossbar.worker.worker002.get_cpus\\n  crossbar.worker.worker002.get_manhole\\n  crossbar.worker.worker002.get_node_id\\n  crossbar.worker.worker002.get_process_info\\n  crossbar.worker.worker002.get_process_monitor\\n  crossbar.worker.worker002.get_process_stats\\n  crossbar.worker.worker002.get_profile\\n  crossbar.worker.worker002.get_profilers\\n  crossbar.worker.worker002.get_pythonpath\\n  crossbar.worker.worker002.get_router_component\\n  crossbar.worker.worker002.get_router_components\\n  crossbar.worker.worker002.get_router_realm\\n  crossbar.worker.worker002.get_router_realm_link\\n  crossbar.worker.worker002.get_router_realm_links\\n  crossbar.worker.worker002.get_router_realm_role\\n  crossbar.worker.worker002.get_router_realm_roles\\n  crossbar.worker.worker002.get_router_realm_stats\\n  crossbar.worker.worker002.get_router_realms\\n  crossbar.worker.worker002.get_router_transport\\n  crossbar.worker.worker002.get_router_transports\\n  crossbar.worker.worker002.get_web_transport_service\\n  crossbar.worker.worker002.kill_by_authid\\n  crossbar.worker.worker002.set_cpu_affinity\\n  crossbar.worker.worker002.set_node_id\\n  crossbar.worker.worker002.set_process_stats_monitoring\\n  crossbar.worker.worker002.shutdown\\n  crossbar.worker.worker002.start_manhole\\n  crossbar.worker.worker002.start_profiler\\n  crossbar.worker.worker002.start_proxy_backend\\n  crossbar.worker.worker002.start_proxy_transport\\n  crossbar.worker.worker002.start_router_component\\n  crossbar.worker.worker002.start_router_realm\\n  crossbar.worker.worker002.start_router_realm_link\\n  crossbar.worker.worker002.start_router_realm_role\\n  crossbar.worker.worker002.start_router_transport\\n  crossbar.worker.worker002.start_web_transport_service\\n  crossbar.worker.worker002.started\\n  crossbar.worker.worker002.stop_manhole\\n  crossbar.worker.worker002.stop_proxy_transport\\n  crossbar.worker.worker002.stop_router_component\\n  crossbar.worker.worker002.stop_router_realm\\n  crossbar.worker.worker002.stop_router_realm_link\\n  crossbar.worker.worker002.stop_router_realm_role\\n  crossbar.worker.worker002.stop_router_transport\\n  crossbar.worker.worker002.stop_web_transport_service\\n  crossbar.worker.worker002.trigger_gc\\n  crossbar.worker.worker002.uptime\\n  crossbar.worker.worker002.utcnow\\nstart_proxy_transport: transport_id=transport000, config={\\\'type\\\': \\\'web\\\', \\\'endpoint\\\': {\\\'type\\\': \\\'tcp\\\', \\\'port\\\': 80, \\\'shared\\\': True, \\\'backlog\\\': 1024}, \\\'paths\\\': {\\\'/\\\': {\\\'type\\\': \\\'redirect\\\', \\\'url\\\': \\\'https://demo.crossbar.io\\\'}}, \\\'id\\\': \\\'transport000\\\'}\\nStarting router transport "transport000" <crossbar.worker.router.RouterController.start_router_transport>\\nCreating router transport for "transport000" ..\\nRouter transport created for "transport000" [transport_class=<crossbar.worker.transport.RouterWebTransport>]\\nCreated "redirect" Web service on root path "/" of Web transport "transport000"\\nSite starting on 80\\nStarting "redirect" Web service on path "/" of transport "transport000" <crossbar.worker.router.RouterController.start_web_transport_service>\\nstart_proxy_transport: transport_id=transport001, config={\\\'type\\\': \\\'web\\\', \\\'endpoint\\\': {\\\'type\\\': \\\'tcp\\\', \\\'port\\\': 443, \\\'shared\\\': True, \\\'backlog\\\': 1024, \\\'tls\\\': {\\\'key\\\': \\\'server.key\\\', \\\'certificate\\\': \\\'server.crt\\\', \\\'ciphers\\\': \\\'ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES-128-SHA256:ECDHE-RSA-AES-256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES-128-CBC-SHA:DHE-RSA-AES-256-CBC-SHA:AES-128-CBC-SHA:AES-256-CBC-SHA\\\', \\\'dhparam\\\': \\\'dhparam.pem\\\', \\\'chain_certificates\\\': [\\\'intermediate.crt\\\']}}, \\\'paths\\\': {\\\'/\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/_demo_launcher/web\\\'}, \\\'shared\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/_shared-web-resources\\\'}, \\\'info\\\': {\\\'type\\\': \\\'nodeinfo\\\'}, \\\'starterkit\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/iotcookbook/device/pi/components\\\'}, \\\'wpadlab\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/iotcookbook/app/weights/wpadlab/web\\\'}, \\\'wpadeuro\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/iotcookbook/app/weights/wpadeuro\\\'}, \\\'beatbox\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/beatbox\\\'}, \\\'chat\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/chat\\\'}, \\\'colorpicker\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/colorpicker\\\'}, \\\'colorama\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/colorama\\\'}, \\\'gauges\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/gauges\\\'}, \\\'notification\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/notification\\\'}, \\\'pubsub\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/pubsub\\\'}, \\\'sliders\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/sliders\\\'}, \\\'visitors_counter\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/visitors_counter\\\'}, \\\'dashboard\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/dashboard/board\\\'}, \\\'dashboardcontroller\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/dashboard/controller\\\'}, \\\'videocontrol\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/videocontrol/web\\\'}, \\\'spreadsheet\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/spread\\\'}, \\\'widget\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/widget\\\'}, \\\'dispenser\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/iotcookbook/app/dispenser/frontend\\\'}, \\\'smart-replenishment\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbario-projects/smart-replenishment/gastrocool/web\\\', \\\'options\\\': {\\\'enable_directory_listing\\\': True, \\\'mime_types\\\': {\\\'png\\\': \\\'image/png\\\', \\\'svg\\\': \\\'image/svg+xml\\\'}}}, \\\'prodisys\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/project-prodisys/test/web\\\'}, \\\'ws\\\': {\\\'type\\\': \\\'websocket-proxy\\\', \\\'serializers\\\': [\\\'cbor\\\', \\\'msgpack\\\', \\\'json\\\'], \\\'backends\\\': [{\\\'type\\\': \\\'websocket\\\', \\\'endpoint\\\': {\\\'type\\\': \\\'unix\\\', \\\'path\\\': \\\'router.sock\\\'}, \\\'url\\\': \\\'ws://localhost\\\', \\\'serializers\\\': [\\\'json\\\']}], \\\'options\\\': {\\\'allowed_origins\\\': [\\\'*\\\'], \\\'allow_null_origin\\\': True, \\\'enable_webstatus\\\': True, \\\'max_frame_size\\\': 1048576, \\\'max_message_size\\\': 1048576, \\\'auto_fragment_size\\\': 65536, \\\'fail_by_drop\\\': True, \\\'open_handshake_timeout\\\': 2500, \\\'close_handshake_timeout\\\': 1000, \\\'auto_ping_interval\\\': 10000, \\\'auto_ping_timeout\\\': 5000, \\\'auto_ping_size\\\': 4, \\\'compression\\\': {\\\'deflate\\\': {\\\'request_no_context_takeover\\\': False, \\\'request_max_window_bits\\\': 13, \\\'no_context_takeover\\\': False, \\\'max_window_bits\\\': 13, \\\'memory_level\\\': 5}}}}}, \\\'id\\\': \\\'transport001\\\'}\\nStarting router transport "transport001" <crossbar.worker.router.RouterController.start_router_transport>\\nCreating router transport for "transport001" ..\\nRouter transport created for "transport001" [transport_class=<crossbar.worker.transport.RouterWebTransport>]\\nCreated "static" Web service on root path "/" of Web transport "transport001"\\nLoading server TLS key from /node/.crossbar/server.key\\nLoading server TLS certificate from /node/.crossbar/server.crt\\nLoading server TLS chain certificate from /node/.crossbar/intermediate.crt\\nUsing explicit TLS ciphers from config\\nSite (TLS) starting on 443\\nStarting "static" Web service on path "/" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>\\nStarting "static" Web service on path "shared" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>\\nStarting "nodeinfo" Web service on path "info" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>\\nStarting "static" Web service on path "starterkit" of transp\'', 'log_time': 1583180058.7957923}: "\\'type\\'"
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] b'ort "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>'
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "starterkit" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "wpadlab" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "wpadeuro" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "beatbox" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "chat" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "colorpicker" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "colorama" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "gauges" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "notification" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "pubsub" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "sliders" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "visitors_counter" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "dashboard" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "dashboardcontroller" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "videocontrol" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "spreadsheet" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "widget" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "dispenser" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "smart-replenishment" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Proxy        2427] Starting "static" Web service on path "prodisys" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Ok, Proxy worker002 has started Transport transport001
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Ok, Proxy worker002 configured
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Order node to start "Proxy worker003" ..
Mar 02 20:14:18 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:18+0000 [Controller   2418] Starting proxy worker worker003 <crossbar.node.controller.NodeController.start_worker>
Mar 02 20:14:19 demo.eu-central-1.crossbar.io docker[4029]: [1B blob data]
Mar 02 20:14:21 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:21+0000 [Proxy        2432] Starting worker "worker003" for node "demo.eu-central-1.crossbar.io-2418" on realm "crossbar" with personality "edge" <crossbar.worker.proxy.ProxyController>
Mar 02 20:14:21 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:21+0000 [Proxy        2432] Running as PID 2433 on CPython-EPollReactor
Mar 02 20:14:21 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:21+0000 [Proxy        2432] Entering event reactor ...
Mar 02 20:14:21 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:21+0000 [Controller   2418] Router.attach(session=3655369185952223)
Mar 02 20:14:21 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:21+0000 [Controller   2418] Router.attach(session=3655369185952223): attached session 3655369185952223 to router realm "crossbar"
Mar 02 20:14:21 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:21+0000 [Controller   2418] WAMP session statistics DISABLED
Mar 02 20:14:21 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:21+0000 [Proxy        2432] Proxy worker "worker003" session 3655369185952223 initializing ..
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Registered 51 management procedures on realm "crossbar"
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.add_pythonpath
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_cpu_affinity
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_cpu_count
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_cpus
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_manhole
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_node_id
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_process_info
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_process_monitor
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_process_stats
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_profile
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_profilers
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_pythonpath
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_component
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_components
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_realm
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_realm_link
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_realm_links
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_realm_role
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_realm_roles
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_realm_stats
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_realms
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_transport
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_router_transports
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.get_web_transport_service
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.kill_by_authid
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.set_cpu_affinity
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.set_node_id
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.set_process_stats_monitoring
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.shutdown
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_manhole
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_profiler
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_proxy_backend
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_proxy_transport
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_router_component
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_router_realm
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_router_realm_link
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_router_realm_role
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_router_transport
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.start_web_transport_service
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.started
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.stop_manhole
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.stop_proxy_transport
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.stop_router_component
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.stop_router_realm
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.stop_router_realm_link
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.stop_router_realm_role
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.stop_router_transport
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.stop_web_transport_service
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.trigger_gc
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.uptime
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432]   crossbar.worker.worker003.utcnow
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Controller   2418] Ok, node has started Proxy worker003
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Controller   2418] Configuring Proxy worker003 ..
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Controller   2418] Order Proxy worker003 to start Transport transport000
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] start_proxy_transport: transport_id=transport000, config={'type': 'web', 'endpoint': {'type': 'tcp', 'port': 80, 'shared': True, 'backlog': 1024}, 'paths': {'/': {'type': 'redirect', 'url': 'https://demo.crossbar.io'}}, 'id': 'transport000'}
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting router transport "transport000" <crossbar.worker.router.RouterController.start_router_transport>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Creating router transport for "transport000" ..
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Router transport created for "transport000" [transport_class=<crossbar.worker.transport.RouterWebTransport>]
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Created "redirect" Web service on root path "/" of Web transport "transport000"
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Site starting on 80
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "redirect" Web service on path "/" of transport "transport000" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Controller   2418] Ok, Proxy worker003 has started Transport transport000
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Controller   2418] Order Proxy worker003 to start Transport transport001
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] start_proxy_transport: transport_id=transport001, config={'type': 'web', 'endpoint': {'type': 'tcp', 'port': 443, 'shared': True, 'backlog': 1024, 'tls': {'key': 'server.key', 'certificate': 'server.crt', 'ciphers': 'ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES-128-SHA256:ECDHE-RSA-AES-256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES-128-CBC-SHA:DHE-RSA-AES-256-CBC-SHA:AES-128-CBC-SHA:AES-256-CBC-SHA', 'dhparam': 'dhparam.pem', 'chain_certificates': ['intermediate.crt']}}, 'paths': {'/': {'type': 'static', 'directory': 'git/crossbar-examples/demos/_demo_launcher/web'}, 'shared': {'type': 'static', 'directory': 'git/crossbar-examples/_shared-web-resources'}, 'info': {'type': 'nodeinfo'}, 'starterkit': {'type': 'static', 'directory': 'git/iotcookbook/device/pi/components'}, 'wpadlab': {'type': 'static', 'directory': 'git/crossbar-examples/iotcookbook/app/weights/wpadlab/web'}, 'wpadeuro': {'type': 'static', 'directory': 'git/crossbar-examples/iotcookbook/app/weights/wpadeuro'}, 'beatbox': {'type': 'static', 'directory': 'git/crossbar-examples/demos/beatbox'}, 'chat': {'type': 'static', 'directory': 'git/crossbar-examples/demos/chat'}, 'colorpicker': {'type': 'static', 'directory': 'git/crossbar-examples/demos/colorpicker'}, 'colorama': {'type': 'static', 'directory': 'git/crossbar-examples/demos/colorama'}, 'gauges': {'type': 'static', 'directory': 'git/crossbar-examples/demos/gauges'}, 'notification': {'type': 'static', 'directory': 'git/crossbar-examples/demos/notification'}, 'pubsub': {'type': 'static', 'directory': 'git/crossbar-examples/demos/pubsub'}, 'sliders': {'type': 'static', 'directory': 'git/crossbar-examples/demos/sliders'}, 'visitors_counter': {'type': 'static', 'directory': 'git/crossbar-examples/demos/visitors_counter'}, 'dashboard': {'type': 'static', 'directory': 'git/crossbar-examples/demos/dashboard/board'}, 'dashboardcontroller': {'type': 'static', 'directory': 'git/crossbar-examples/demos/dashboard/controller'}, 'videocontrol': {'type': 'static', 'directory': 'git/crossbar-examples/demos/videocontrol/web'}, 'spreadsheet': {'type': 'static', 'directory': 'git/crossbar-examples/demos/spread'}, 'widget': {'type': 'static', 'directory': 'git/crossbar-examples/demos/widget'}, 'dispenser': {'type': 'static', 'directory': 'git/crossbar-examples/iotcookbook/app/dispenser/frontend'}, 'smart-replenishment': {'type': 'static', 'directory': 'git/crossbario-projects/smart-replenishment/gastrocool/web', 'options': {'enable_directory_listing': True, 'mime_types': {'png': 'image/png', 'svg': 'image/svg+xml'}}}, 'prodisys': {'type': 'static', 'directory': 'git/project-prodisys/test/web'}, 'ws': {'type': 'websocket-proxy', 'serializers': ['cbor', 'msgpack', 'json'], 'backends': [{'type': 'websocket', 'endpoint': {'type': 'unix', 'path': 'router.sock'}, 'url': 'ws://localhost', 'serializers': ['json']}], 'options': {'allowed_origins': ['*'], 'allow_null_origin': True, 'enable_webstatus': True, 'max_frame_size': 1048576, 'max_message_size': 1048576, 'auto_fragment_size': 65536, 'fail_by_drop': True, 'open_handshake_timeout': 2500, 'close_handshake_timeout': 1000, 'auto_ping_interval': 10000, 'auto_ping_timeout': 5000, 'auto_ping_size': 4, 'compression': {'deflate': {'request_no_context_takeover': False, 'request_max_window_bits': 13, 'no_context_takeover': False, 'max_window_bits': 13, 'memory_level': 5}}}}}, 'id': 'transport001'}
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting router transport "transport001" <crossbar.worker.router.RouterController.start_router_transport>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Creating router transport for "transport001" ..
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Router transport created for "transport001" [transport_class=<crossbar.worker.transport.RouterWebTransport>]
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Created "static" Web service on root path "/" of Web transport "transport001"
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Loading server TLS key from /node/.crossbar/server.key
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Loading server TLS certificate from /node/.crossbar/server.crt
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Loading server TLS chain certificate from /node/.crossbar/intermediate.crt
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Using explicit TLS ciphers from config
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Site (TLS) starting on 443
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "/" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "shared" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "nodeinfo" Web service on path "info" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Unable to format event {'cb_namespace': 'FD1', 'log_system': 'Proxy        2432', 'log_logger': <Logger 'crossbar.worker.proxy.ProxyWorkerProcess'>, 'log_level': <LogLevel=info>, 'log_namespace': 'crossbar.worker.proxy.ProxyWorkerProcess', 'log_source': None, 'log_format': 'b\'Starting worker "worker003" for node "demo.eu-central-1.crossbar.io-2418" on realm "crossbar" with personality "edge" <crossbar.worker.proxy.ProxyController>\\nRunning as PID 2433 on CPython-EPollReactor\\nEntering event reactor ...\\nProxy worker "worker003" session 3655369185952223 initializing ..\\nRegistered 51 management procedures on realm "crossbar"\\n  crossbar.worker.worker003.add_pythonpath\\n  crossbar.worker.worker003.get_cpu_affinity\\n  crossbar.worker.worker003.get_cpu_count\\n  crossbar.worker.worker003.get_cpus\\n  crossbar.worker.worker003.get_manhole\\n  crossbar.worker.worker003.get_node_id\\n  crossbar.worker.worker003.get_process_info\\n  crossbar.worker.worker003.get_process_monitor\\n  crossbar.worker.worker003.get_process_stats\\n  crossbar.worker.worker003.get_profile\\n  crossbar.worker.worker003.get_profilers\\n  crossbar.worker.worker003.get_pythonpath\\n  crossbar.worker.worker003.get_router_component\\n  crossbar.worker.worker003.get_router_components\\n  crossbar.worker.worker003.get_router_realm\\n  crossbar.worker.worker003.get_router_realm_link\\n  crossbar.worker.worker003.get_router_realm_links\\n  crossbar.worker.worker003.get_router_realm_role\\n  crossbar.worker.worker003.get_router_realm_roles\\n  crossbar.worker.worker003.get_router_realm_stats\\n  crossbar.worker.worker003.get_router_realms\\n  crossbar.worker.worker003.get_router_transport\\n  crossbar.worker.worker003.get_router_transports\\n  crossbar.worker.worker003.get_web_transport_service\\n  crossbar.worker.worker003.kill_by_authid\\n  crossbar.worker.worker003.set_cpu_affinity\\n  crossbar.worker.worker003.set_node_id\\n  crossbar.worker.worker003.set_process_stats_monitoring\\n  crossbar.worker.worker003.shutdown\\n  crossbar.worker.worker003.start_manhole\\n  crossbar.worker.worker003.start_profiler\\n  crossbar.worker.worker003.start_proxy_backend\\n  crossbar.worker.worker003.start_proxy_transport\\n  crossbar.worker.worker003.start_router_component\\n  crossbar.worker.worker003.start_router_realm\\n  crossbar.worker.worker003.start_router_realm_link\\n  crossbar.worker.worker003.start_router_realm_role\\n  crossbar.worker.worker003.start_router_transport\\n  crossbar.worker.worker003.start_web_transport_service\\n  crossbar.worker.worker003.started\\n  crossbar.worker.worker003.stop_manhole\\n  crossbar.worker.worker003.stop_proxy_transport\\n  crossbar.worker.worker003.stop_router_component\\n  crossbar.worker.worker003.stop_router_realm\\n  crossbar.worker.worker003.stop_router_realm_link\\n  crossbar.worker.worker003.stop_router_realm_role\\n  crossbar.worker.worker003.stop_router_transport\\n  crossbar.worker.worker003.stop_web_transport_service\\n  crossbar.worker.worker003.trigger_gc\\n  crossbar.worker.worker003.uptime\\n  crossbar.worker.worker003.utcnow\\nstart_proxy_transport: transport_id=transport000, config={\\\'type\\\': \\\'web\\\', \\\'endpoint\\\': {\\\'type\\\': \\\'tcp\\\', \\\'port\\\': 80, \\\'shared\\\': True, \\\'backlog\\\': 1024}, \\\'paths\\\': {\\\'/\\\': {\\\'type\\\': \\\'redirect\\\', \\\'url\\\': \\\'https://demo.crossbar.io\\\'}}, \\\'id\\\': \\\'transport000\\\'}\\nStarting router transport "transport000" <crossbar.worker.router.RouterController.start_router_transport>\\nCreating router transport for "transport000" ..\\nRouter transport created for "transport000" [transport_class=<crossbar.worker.transport.RouterWebTransport>]\\nCreated "redirect" Web service on root path "/" of Web transport "transport000"\\nSite starting on 80\\nStarting "redirect" Web service on path "/" of transport "transport000" <crossbar.worker.router.RouterController.start_web_transport_service>\\nstart_proxy_transport: transport_id=transport001, config={\\\'type\\\': \\\'web\\\', \\\'endpoint\\\': {\\\'type\\\': \\\'tcp\\\', \\\'port\\\': 443, \\\'shared\\\': True, \\\'backlog\\\': 1024, \\\'tls\\\': {\\\'key\\\': \\\'server.key\\\', \\\'certificate\\\': \\\'server.crt\\\', \\\'ciphers\\\': \\\'ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES-128-SHA256:ECDHE-RSA-AES-256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES-128-CBC-SHA:DHE-RSA-AES-256-CBC-SHA:AES-128-CBC-SHA:AES-256-CBC-SHA\\\', \\\'dhparam\\\': \\\'dhparam.pem\\\', \\\'chain_certificates\\\': [\\\'intermediate.crt\\\']}}, \\\'paths\\\': {\\\'/\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/_demo_launcher/web\\\'}, \\\'shared\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/_shared-web-resources\\\'}, \\\'info\\\': {\\\'type\\\': \\\'nodeinfo\\\'}, \\\'starterkit\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/iotcookbook/device/pi/components\\\'}, \\\'wpadlab\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/iotcookbook/app/weights/wpadlab/web\\\'}, \\\'wpadeuro\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/iotcookbook/app/weights/wpadeuro\\\'}, \\\'beatbox\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/beatbox\\\'}, \\\'chat\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/chat\\\'}, \\\'colorpicker\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/colorpicker\\\'}, \\\'colorama\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/colorama\\\'}, \\\'gauges\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/gauges\\\'}, \\\'notification\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/notification\\\'}, \\\'pubsub\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/pubsub\\\'}, \\\'sliders\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/sliders\\\'}, \\\'visitors_counter\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/visitors_counter\\\'}, \\\'dashboard\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/dashboard/board\\\'}, \\\'dashboardcontroller\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/dashboard/controller\\\'}, \\\'videocontrol\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/videocontrol/web\\\'}, \\\'spreadsheet\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/spread\\\'}, \\\'widget\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/demos/widget\\\'}, \\\'dispenser\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbar-examples/iotcookbook/app/dispenser/frontend\\\'}, \\\'smart-replenishment\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/crossbario-projects/smart-replenishment/gastrocool/web\\\', \\\'options\\\': {\\\'enable_directory_listing\\\': True, \\\'mime_types\\\': {\\\'png\\\': \\\'image/png\\\', \\\'svg\\\': \\\'image/svg+xml\\\'}}}, \\\'prodisys\\\': {\\\'type\\\': \\\'static\\\', \\\'directory\\\': \\\'git/project-prodisys/test/web\\\'}, \\\'ws\\\': {\\\'type\\\': \\\'websocket-proxy\\\', \\\'serializers\\\': [\\\'cbor\\\', \\\'msgpack\\\', \\\'json\\\'], \\\'backends\\\': [{\\\'type\\\': \\\'websocket\\\', \\\'endpoint\\\': {\\\'type\\\': \\\'unix\\\', \\\'path\\\': \\\'router.sock\\\'}, \\\'url\\\': \\\'ws://localhost\\\', \\\'serializers\\\': [\\\'json\\\']}], \\\'options\\\': {\\\'allowed_origins\\\': [\\\'*\\\'], \\\'allow_null_origin\\\': True, \\\'enable_webstatus\\\': True, \\\'max_frame_size\\\': 1048576, \\\'max_message_size\\\': 1048576, \\\'auto_fragment_size\\\': 65536, \\\'fail_by_drop\\\': True, \\\'open_handshake_timeout\\\': 2500, \\\'close_handshake_timeout\\\': 1000, \\\'auto_ping_interval\\\': 10000, \\\'auto_ping_timeout\\\': 5000, \\\'auto_ping_size\\\': 4, \\\'compression\\\': {\\\'deflate\\\': {\\\'request_no_context_takeover\\\': False, \\\'request_max_window_bits\\\': 13, \\\'no_context_takeover\\\': False, \\\'max_window_bits\\\': 13, \\\'memory_level\\\': 5}}}}}, \\\'id\\\': \\\'transport001\\\'}\\nStarting router transport "transport001" <crossbar.worker.router.RouterController.start_router_transport>\\nCreating router transport for "transport001" ..\\nRouter transport created for "transport001" [transport_class=<crossbar.worker.transport.RouterWebTransport>]\\nCreated "static" Web service on root path "/" of Web transport "transport001"\\nLoading server TLS key from /node/.crossbar/server.key\\nLoading server TLS certificate from /node/.crossbar/server.crt\\nLoading server TLS chain certificate from /node/.crossbar/intermediate.crt\\nUsing explicit TLS ciphers from config\\nSite (TLS) starting on 443\\nStarting "static" Web service on path "/" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>\\nStarting "static" Web service on path "shared" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>\\nStarting "nodeinfo" Web service on path "info" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>\\nStarting "static" Web service on path "starterkit" of transp\'', 'log_time': 1583180062.0923452}: "\\'type\\'"
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] b'ort "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>'
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "starterkit" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "wpadlab" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "wpadeuro" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "beatbox" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "chat" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "colorpicker" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "colorama" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "gauges" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "notification" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "pubsub" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "sliders" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "visitors_counter" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "dashboard" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "dashboardcontroller" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "videocontrol" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "spreadsheet" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "widget" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "dispenser" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "smart-replenishment" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Proxy        2432] Starting "static" Web service on path "prodisys" of transport "transport001" <crossbar.worker.router.RouterController.start_web_transport_service>
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Controller   2418] Ok, Proxy worker003 has started Transport transport001
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Controller   2418] Ok, Proxy worker003 configured
Mar 02 20:14:22 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:22+0000 [Controller   2418] Ok, local node configuration booted successfully!
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:37+0000 [Proxy        2432] Unhandled error in Deferred:
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: {"isError": true, "log_time": 1583180077.3202696, "level": "critical", "namespace": "twisted.internet.defer", "text": "Unhandled error in Deferred:"}
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:37+0000 [Proxy        2432] Traceback (most recent call last):
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 1235, in consumeData
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 2833, in processHandshake
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/txaio/tx.py", line 443, in add_callbacks
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py", line 311, in addCallbacks
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: --- <exception caught here> ---
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py", line 654, in _runCallbacks
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 2985, in succeedHandshake
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 1329, in sendData
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/_newtls.py", line 189, in write
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: builtins.AttributeError: 'FrontendProxyProtocol' object has no attribute 'write'
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: [1B blob data]
Mar 02 20:14:37 demo.eu-central-1.crossbar.io docker[4029]: {"debugInfo": "", "log_time": 1583180077.3223608, "level": "critical", "namespace": "twisted.internet.defer", "text": "\nTraceback (most recent call last):\n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 1235, in consumeData\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 2833, in processHandshake\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/txaio/tx.py\", line 443, in add_callbacks\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py\", line 311, in addCallbacks\n    \n--- <exception caught here> ---\n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py\", line 654, in _runCallbacks\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 2985, in succeedHandshake\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 1329, in sendData\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/_newtls.py\", line 189, in write\n    \nbuiltins.AttributeError: 'FrontendProxyProtocol' object has no attribute 'write'\n"}
Mar 02 20:14:42 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:42+0000 [Controller   2418] Native worker connection closed uncleanly: A process has ended with a probable error condition: process ended by signal 11.
Mar 02 20:14:42 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:42+0000 [Controller   2418] Router.detach(session=3655369185952223)
Mar 02 20:14:42 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:42+0000 [Controller   2418] Router.detach(session=3655369185952223): detached sessions [3655369185952223] from router realm "crossbar"
Mar 02 20:14:42 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:42+0000 [Controller   2418] Node worker worker003 ended with error ([Failure instance: Traceback (failure with no frames): <class 'twisted.internet.error.ProcessTerminated'>: A process has ended with a probable error condition: process ended by signal 11.
Mar 02 20:14:42 demo.eu-central-1.crossbar.io docker[4029]: ])
Mar 02 20:14:42 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:42+0000 [Controller   2418] Checking for node shutdown: worker_exit_success=False, shutdown_requested=False, node_shutdown_triggers=['shutdown_on_shutdown_requested']
Mar 02 20:14:42 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:42+0000 [Controller   2418] Node will continue to run!
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:48+0000 [Proxy        2427] Unhandled error in Deferred:
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: {"isError": true, "log_time": 1583180088.448401, "level": "critical", "namespace": "twisted.internet.defer", "text": "Unhandled error in Deferred:"}
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:48+0000 [Proxy        2427] Traceback (most recent call last):
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 1235, in consumeData
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 2833, in processHandshake
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/txaio/tx.py", line 443, in add_callbacks
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py", line 311, in addCallbacks
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: --- <exception caught here> ---
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py", line 654, in _runCallbacks
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 2985, in succeedHandshake
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 1329, in sendData
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/_newtls.py", line 189, in write
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: builtins.AttributeError: 'FrontendProxyProtocol' object has no attribute 'write'
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [1B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: {"debugInfo": "", "log_time": 1583180088.4506273, "level": "critical", "namespace": "twisted.internet.defer", "text": "\nTraceback (most recent call last):\n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 1235, in consumeData\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 2833, in processHandshake\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/txaio/tx.py\", line 443, in add_callbacks\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py\", line 311, in addCallbacks\n    \n--- <exception caught here> ---\n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py\", line 654, in _runCallbacks\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 2985, in succeedHandshake\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 1329, in sendData\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/_newtls.py\", line 189, in write\n    \nbuiltins.AttributeError: 'FrontendProxyProtocol' object has no attribute 'write'\n"}
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:48+0000 [Proxy        2427] Unhandled error in Deferred:
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: {"isError": true, "log_time": 1583180088.4933171, "level": "critical", "namespace": "twisted.internet.defer", "text": "Unhandled error in Deferred:"}
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:48+0000 [Proxy        2427] Traceback (most recent call last):
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 1235, in consumeData
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 2833, in processHandshake
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/txaio/tx.py", line 443, in add_callbacks
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py", line 311, in addCallbacks
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: --- <exception caught here> ---
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py", line 654, in _runCallbacks
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 2985, in succeedHandshake
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py", line 1329, in sendData
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]:   File ".tox/buildexe/lib/python3.7/site-packages/twisted/internet/_newtls.py", line 189, in write
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [5B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: builtins.AttributeError: 'FrontendProxyProtocol' object has no attribute 'write'
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: [1B blob data]
Mar 02 20:14:48 demo.eu-central-1.crossbar.io docker[4029]: {"debugInfo": "", "log_time": 1583180088.4952443, "level": "critical", "namespace": "twisted.internet.defer", "text": "\nTraceback (most recent call last):\n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 1235, in consumeData\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 2833, in processHandshake\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/txaio/tx.py\", line 443, in add_callbacks\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py\", line 311, in addCallbacks\n    \n--- <exception caught here> ---\n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/defer.py\", line 654, in _runCallbacks\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 2985, in succeedHandshake\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/autobahn/websocket/protocol.py\", line 1329, in sendData\n    \n  File \".tox/buildexe/lib/python3.7/site-packages/twisted/internet/_newtls.py\", line 189, in write\n    \nbuiltins.AttributeError: 'FrontendProxyProtocol' object has no attribute 'write'\n"}
Mar 02 20:14:53 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:53+0000 [Controller   2418] Native worker connection closed uncleanly: A process has ended with a probable error condition: process ended by signal 11.
Mar 02 20:14:53 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:53+0000 [Controller   2418] Router.detach(session=8935225597186462)
Mar 02 20:14:53 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:53+0000 [Controller   2418] Router.detach(session=8935225597186462): detached sessions [8935225597186462] from router realm "crossbar"
Mar 02 20:14:53 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:53+0000 [Controller   2418] Node worker worker002 ended with error ([Failure instance: Traceback (failure with no frames): <class 'twisted.internet.error.ProcessTerminated'>: A process has ended with a probable error condition: process ended by signal 11.
Mar 02 20:14:53 demo.eu-central-1.crossbar.io docker[4029]: ])
Mar 02 20:14:53 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:53+0000 [Controller   2418] Checking for node shutdown: worker_exit_success=False, shutdown_requested=False, node_shutdown_triggers=['shutdown_on_shutdown_requested']
Mar 02 20:14:53 demo.eu-central-1.crossbar.io docker[4029]: 2020-03-02T20:14:53+0000 [Controller   2418] Node will continue to run!
om26er commented 4 years ago

Here is the config file one could use to reproduce that issue

{
    "$schema": "https://raw.githubusercontent.com/crossbario/crossbar/master/crossbar.json",
    "version": 2,
    "controller": {},
    "workers": [
        {
            "type": "router",
            "realms": [
                {
                    "id": "io.crossbar.demo",
                    "name": "crossbardemo",
                    "roles": [
                        {
                            "name": "anonymous",
                            "permissions": [
                                {
                                    "uri": "io.crossbar.demo.",
                                    "match": "prefix",
                                    "allow": {
                                        "call": true,
                                        "register": true,
                                        "publish": true,
                                        "subscribe": true
                                    },
                                    "disclose": {
                                        "caller": true,
                                        "publisher": true
                                    },
                                    "cache": true
                                },
                                {
                                    "uri": "wamp.",
                                    "match": "prefix",
                                    "allow": {
                                        "call": false,
                                        "register": false,
                                        "publish": false,
                                        "subscribe": true
                                    },
                                    "disclose": {
                                        "caller": false,
                                        "publisher": false
                                    },
                                    "cache": true
                                },
                                {
                                    "uri": "wamp.subscription.get_events",
                                    "match": "exact",
                                    "allow": {
                                        "call": true,
                                        "register": false,
                                        "publish": false,
                                        "subscribe": false
                                    },
                                    "disclose": {
                                        "caller": false,
                                        "publisher": false
                                    },
                                    "cache": true
                                }
                            ]
                        }
                    ],
                    "store": {
                        "type": "memory",
                        "event-history": [
                            {
                                "uri": "io.crossbar.demo.wpad.wpad.4126748144.on_wpad"
                            }
                        ],
                        "limit": 2000
                    }
                },
                {
                    "id": "io.crossbar.iotcookbook",
                    "name": "iot_cookbook",
                    "roles": [
                        {
                            "name": "anonymous",
                            "permissions": [
                                {
                                    "uri": "",
                                    "match": "prefix",
                                    "allow": {
                                        "call": true,
                                        "register": true,
                                        "publish": true,
                                        "subscribe": true
                                    },
                                    "disclose": {
                                        "caller": false,
                                        "publisher": false
                                    },
                                    "cache": true
                                }
                            ]
                        }
                    ]
                }
            ],
            "transports": [
                {
                    "type": "websocket",
                    "endpoint": {
                        "type": "unix",
                        "path": "router.sock"
                    },
                    "serializers": ["json", "cbor"]
                }
            ]
        },
        {
            "type": "proxy",
            "options": {
            },
            "transports": [
                {
                    "type": "web",
                    "endpoint": {
                        "type": "tcp",
                        "port": 80,
                        "shared": true,
                        "backlog": 1024
                    },
                    "paths": {
                        "/": {
                            "type": "redirect",
                            "url": "https://demo.crossbar.io"
                        }
                    }
                },
                {
                    "type": "web",
                    "endpoint": {
                        "type": "tcp",
                        "port": 443,
                        "shared": true,
                        "backlog": 1024,
                        "tls": {
                            "key": "server.key",
                            "certificate": "server.crt",
                            "ciphers": "ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES-128-SHA256:ECDHE-RSA-AES-256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES-128-CBC-SHA:DHE-RSA-AES-256-CBC-SHA:AES-128-CBC-SHA:AES-256-CBC-SHA",
                            "dhparam": "dhparam.pem",
                            "chain_certificates": ["intermediate.crt"]
                        }
                    },
                    "paths": {
                        "/": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/_demo_launcher/web"
                        },
                        "shared": {
                            "type": "static",
                            "directory": "git/crossbar-examples/_shared-web-resources"
                        },
                        "info": {
                            "type": "nodeinfo"
                        },
                        "starterkit": {
                            "type": "static",
                            "directory": "git/iotcookbook/device/pi/components"
                        },
                        "wpadlab": {
                            "type": "static",
                            "directory": "git/crossbar-examples/iotcookbook/app/weights/wpadlab/web"
                        },
                        "wpadeuro": {
                            "type": "static",
                            "directory": "git/crossbar-examples/iotcookbook/app/weights/wpadeuro"
                        },
                        "beatbox": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/beatbox"
                        },
                        "chat": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/chat"
                        },
                        "colorpicker": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/colorpicker"
                        },
                        "colorama": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/colorama"
                        },
                        "gauges": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/gauges"
                        },
                        "notification": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/notification"
                        },
                        "pubsub": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/pubsub"
                        },
                        "sliders": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/sliders"
                        },
                        "visitors_counter": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/visitors_counter"
                        },
                        "dashboard": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/dashboard/board"
                        },
                        "dashboardcontroller": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/dashboard/controller"
                        },
                        "videocontrol": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/videocontrol/web"
                        },
                        "spreadsheet": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/spread"
                        },
                        "widget": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/widget"
                        },
                        "dispenser": {
                            "type": "static",
                            "directory": "git/crossbar-examples/iotcookbook/app/dispenser/frontend"
                        },
                        "smart-replenishment": {
                            "type": "static",
                            "directory": "git/crossbario-projects/smart-replenishment/gastrocool/web",
                            "options": {
                                "enable_directory_listing": true,
                                "mime_types": {
                                    "png": "image/png",
                                    "svg": "image/svg+xml"
                                }
                            }
                        },
                        "prodisys": {
                            "type": "static",
                            "directory": "git/project-prodisys/test/web"
                        },
                        "ws": {
                            "type": "websocket-proxy",
                            "serializers": [
                                "cbor", "msgpack", "json"
                            ],
                            "backends": [
                                {
                                    "type": "websocket",
                                    "endpoint": {
                                        "type": "unix",
                                        "path": "router.sock"
                                    },
                                    "url": "ws://localhost",
                                    "serializers": ["json"]
                                }
                            ],
                            "options": {
                                "allowed_origins": ["*"],
                                "allow_null_origin": true,
                                "enable_webstatus": true,
                                "max_frame_size": 1048576,
                                "max_message_size": 1048576,
                                "auto_fragment_size": 65536,
                                "fail_by_drop": true,
                                "open_handshake_timeout": 2500,
                                "close_handshake_timeout": 1000,
                                "auto_ping_interval": 10000,
                                "auto_ping_timeout": 5000,
                                "auto_ping_size": 4,
                                "compression": {
                                    "deflate": {
                                        "request_no_context_takeover": false,
                                        "request_max_window_bits": 13,
                                        "no_context_takeover": false,
                                        "max_window_bits": 13,
                                        "memory_level": 5
                                    }
                                }
                            }
                        }
                    }
                }
            ]
        },
        {
            "type": "proxy",
            "options": {
            },
            "transports": [
                {
                    "type": "web",
                    "endpoint": {
                        "type": "tcp",
                        "port": 80,
                        "shared": true,
                        "backlog": 1024
                    },
                    "paths": {
                        "/": {
                            "type": "redirect",
                            "url": "https://demo.crossbar.io"
                        }
                    }
                },
                {
                    "type": "web",
                    "endpoint": {
                        "type": "tcp",
                        "port": 443,
                        "shared": true,
                        "backlog": 1024,
                        "tls": {
                            "key": "server.key",
                            "certificate": "server.crt",
                            "ciphers": "ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES-128-SHA256:ECDHE-RSA-AES-256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES-128-CBC-SHA:DHE-RSA-AES-256-CBC-SHA:AES-128-CBC-SHA:AES-256-CBC-SHA",
                            "dhparam": "dhparam.pem",
                            "chain_certificates": ["intermediate.crt"]
                        }
                    },
                    "paths": {
                        "/": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/_demo_launcher/web"
                        },
                        "shared": {
                            "type": "static",
                            "directory": "git/crossbar-examples/_shared-web-resources"
                        },
                        "info": {
                            "type": "nodeinfo"
                        },
                        "starterkit": {
                            "type": "static",
                            "directory": "git/iotcookbook/device/pi/components"
                        },
                        "wpadlab": {
                            "type": "static",
                            "directory": "git/crossbar-examples/iotcookbook/app/weights/wpadlab/web"
                        },
                        "wpadeuro": {
                            "type": "static",
                            "directory": "git/crossbar-examples/iotcookbook/app/weights/wpadeuro"
                        },
                        "beatbox": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/beatbox"
                        },
                        "chat": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/chat"
                        },
                        "colorpicker": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/colorpicker"
                        },
                        "colorama": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/colorama"
                        },
                        "gauges": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/gauges"
                        },
                        "notification": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/notification"
                        },
                        "pubsub": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/pubsub"
                        },
                        "sliders": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/sliders"
                        },
                        "visitors_counter": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/visitors_counter"
                        },
                        "dashboard": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/dashboard/board"
                        },
                        "dashboardcontroller": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/dashboard/controller"
                        },
                        "videocontrol": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/videocontrol/web"
                        },
                        "spreadsheet": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/spread"
                        },
                        "widget": {
                            "type": "static",
                            "directory": "git/crossbar-examples/demos/widget"
                        },
                        "dispenser": {
                            "type": "static",
                            "directory": "git/crossbar-examples/iotcookbook/app/dispenser/frontend"
                        },
                        "smart-replenishment": {
                            "type": "static",
                            "directory": "git/crossbario-projects/smart-replenishment/gastrocool/web",
                            "options": {
                                "enable_directory_listing": true,
                                "mime_types": {
                                    "png": "image/png",
                                    "svg": "image/svg+xml"
                                }
                            }
                        },
                        "prodisys": {
                            "type": "static",
                            "directory": "git/project-prodisys/test/web"
                        },
                        "ws": {
                            "type": "websocket-proxy",
                            "serializers": [
                                "cbor", "msgpack", "json"
                            ],
                            "backends": [
                                {
                                    "type": "websocket",
                                    "endpoint": {
                                        "type": "unix",
                                        "path": "router.sock"
                                    },
                                    "url": "ws://localhost",
                                    "serializers": ["json"]
                                }
                            ],
                            "options": {
                                "allowed_origins": ["*"],
                                "allow_null_origin": true,
                                "enable_webstatus": true,
                                "max_frame_size": 1048576,
                                "max_message_size": 1048576,
                                "auto_fragment_size": 65536,
                                "fail_by_drop": true,
                                "open_handshake_timeout": 2500,
                                "close_handshake_timeout": 1000,
                                "auto_ping_interval": 10000,
                                "auto_ping_timeout": 5000,
                                "auto_ping_size": 4,
                                "compression": {
                                    "deflate": {
                                        "request_no_context_takeover": false,
                                        "request_max_window_bits": 13,
                                        "no_context_takeover": false,
                                        "max_window_bits": 13,
                                        "memory_level": 5
                                    }
                                }
                            }
                        }
                    }
                }
            ]
        }
    ]
}
oberstet commented 4 years ago

mmh, according to the config, the connection between the proxy workers to the router worker is over UDS without TLS:

"backends": [
                                {
                                    "type": "websocket",
                                    "endpoint": {
                                        "type": "unix",
                                        "path": "router.sock"
                                    },
                                    "url": "ws://localhost",
                                    "serializers": ["json"]
                                }
                            ],

the proxy worker do listen on TLS to the outside world:

                {
                    "type": "web",
                    "endpoint": {
                        "type": "tcp",
                        "port": 443,
                        "shared": true,
                        "backlog": 1024,
                        "tls": {
                            "key": "server.key",
                            "certificate": "server.crt",
                            "ciphers": "ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES-128-SHA256:ECDHE-RSA-AES-256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES-128-CBC-SHA:DHE-RSA-AES-256-CBC-SHA:AES-128-CBC-SHA:AES-256-CBC-SHA",
                            "dhparam": "dhparam.pem",
                            "chain_certificates": ["intermediate.crt"]
                        }
                    },
oberstet commented 4 years ago

and the router worker only listens on the UDS (with no TLS):

            "transports": [
                {
                    "type": "websocket",
                    "endpoint": {
                        "type": "unix",
                        "path": "router.sock"
                    },
                    "serializers": ["json", "cbor"]
                }
            ]

the config is exactly right in how it sets up things! the proxy=>router communication should be over UDS with no TLS, and the proxy workers accept TLS from outside.

there is only 1 tiny improvment: it should be "serializers": ["cbor"] in both the backend connection configuration and the UDS router transport. cbor is the most efficient/performant transport (on pypy). this config wiil hard-select cbor

meejah commented 4 years ago

Is this happening on every connection? (I've switched around my example proxy setup to use self-signed certificates -- the same ones in the autobahn examples -- and I can connect fine)

om26er commented 4 years ago

Is this happening on every connection? (I've switched around my example proxy setup to use self-signed certificates -- the same ones in the autobahn examples -- and I can connect fine)

On one of the demo instance, when I use that config, things don't really go past far enough, since the proxy workers die down on start.

meejah commented 4 years ago

Okay I just made sure txaio, autobahn and crossbar are locally up-to-date to master and re-created all venvs, now reporting this for crossbar version:

 Crossbar.io        : 20.2.1
   txaio            : 20.1.1
   Autobahn         : 20.3.1-dev
     UTF8 Validator : autobahn
     XOR Masker     : autobahn
     JSON Codec     : stdlib
     MsgPack Codec  : msgpack-1.0.0
     CBOR Codec     : cbor-1.0.0
     UBJSON Codec   : ubjson-0.14.0
     FlatBuffers    : flatbuffers-1.11
   Twisted          : 19.7.0dev0-EPollReactor
   LMDB             : 0.98/lmdb-0.9.22
   Python           : 3.6.9/CPython
 Frozen executable  : no
 Operating system   : Linux-4.19.0-5-amd64-x86_64-with-debian-buster-sid
 Host machine       : x86_64
 Release key        : RWRNmnwUaF+fsGoUNR59gHdfKU0HLUTZSQmXzrcMODXwOpq17UWV4G2G

After all updates above the examples still work for me. This is very similar to the crossbar-examples setup: two proxy workers (both now on TLS, with self-signed certificates) and a single callee and caller process (they can connect and make a successful call). I'll keep looking through the logs / setup above to see if I can re-create but thus far, I can't :/

meejah commented 4 years ago

Also just tried with release versions of autobahn + crossbar (still works).

meejah commented 4 years ago

ah, wait, I was using the wrong port for the caller so not going through the proxy. Ooops! Sorry for the noise, I can re-produce.

meejah commented 4 years ago

Well, at least I've repeated it .. still confused (mostly as to why the code-paths are so different for TLS/non-TLS)

meejah commented 4 years ago

Seems to be actually an autobahn issue (and/or Twisted change?) but see if this works for you https://github.com/crossbario/autobahn-python/pull/1339

om26er commented 4 years ago

@meejah that works fine