Groups keyboard shortcuts have been updated

Dismiss

See shortcuts

OLA RDM Tests with Enttec USB Pro Mk II

123 views

Skip to first unread message

joseph...@gmail.com

unread,

Apr 17, 2017, 8:10:45 PM4/17/17

to RDM Testing

I'm not getting any RDM requests out of an Enttec USB Pro Mk II running firmware 4.5.
Is it supported?

What I have done so far:

Installed Debian 8 into a VirtualBox VM under Windows.
Installed the OLA and RDM Test packages with apt-get.
Started the HTML interface to OLA.
The version reported is 0.9.1
(Enttec Open DMX driver was already active)
Set up universe 1 to output to Enttec USB Pro port 1 of 2 (or port 0 of 1 depending on how you look at it...)

At this point OLA sees the Enttec interface and reports it's serial number and firmware version 4.5.
With the OLA DMX Console I can control the dimmers of my device connected to the USB Pro.
However, when I start a discovery, it just hangs in discovery mode.

When I start up the RDM Test HTML interface, there are no universes to test in the universe drop-down menu.

My DMX device, a 2 channel dimmer, is under development. I have successfully tested RDM features using the Swisson XMT-350 test controller and LumenRadio's SuperNova controller via their CRMX wireless DMX interfaces. I have a debugger running on my hardware and can see if it is receiving any 0xCC start codes. It is not. So it appears that the Enttec USB Pro Mk II does not support RDM. That, or I have just missed something in the configuration...

- Joe

Peter Newman

unread,

Apr 17, 2017, 8:27:05 PM4/17/17

to RDM Testing

Hi Joe,

Is it showing one or both ports of your Mk II? Enttec released a Mk II B version recently, which only has full support in 0.10.2 of OLA, but I think the first port should just work fine regardless.

The Enttec Mk II should support RDM. Can we see the output of ola_dev_info please.

Are you saying the universe drop down in the RDM tests is entirely empty?

You could also patch the Dummy plugin to another universe and confirm that appears and you can run RDM tests against that as a test.

Can you run olad with -l 4 and send over the logs. To do do, start OLA via the init script or however it's normally run, find the relevant command with ps aux | grep -i olad, then stop olad, and run the same command with -l modified to 4, or appended if not currently present on the command line. Then post the output it gives. It may be running with the long option --log-level (if so change that instead), and the syslog option (remove that), logs will then go to STDOUT/STDERR so you can just redirect them into a file. Alternatively you can filter them from syslog if you'd prefer.

If you're in the UK or Europe, you might also be interested in this which is coming up soon:

http://www.plasa.org/rdm/

This may also make interesting reading:

http://www.lightingandsoundamerica.com/mailing/PLASAProtocol/PSpring12_RDMCornerCases.pdf

joseph...@gmail.com

unread,

Apr 18, 2017, 7:27:49 PM4/18/17

to RDM Testing

Two things I just noticed:

1) I have no /dev/dmx0, even though this is defined in ola-opendmx.conf.
2) When the Enttec box is attached (i.e the USB port is "Captured" by the VM) it sends out a DISC_UN_MUTE, but that is all-- no DISC_UNIQUE_BRANCH. But this is independent of OLA. When discovery is attempted from OLA Admin, there is no RDM output from the Enttec box.

In answer to your questions:

On the OLA Admin New Universe screen, there are 4 listings for the Enttec Usb Pro Device:
Enttec Usb Pro Device     Input     Serial#:02123447, firmware 4.5
Enttec Usb Pro Device     Input     Serial#:02123447, firmware 4.5
Enttec Usb Pro Device     Output    Serial#:02123447, firmware 4.5
Enttec Usb Pro Device     Output    Serial#:02123447, firmware 4.5

(There is no port number per entry displayed which I thought was strange.)
If I assign an output to a universe it gets removed from that list.

On the Home screen:
Universe #     Universe Name     Input Ports     Output Ports     RDM Devices
1              test#1            0               1                0
2              Test#2            0   1                0
7              Dummy             0               1              6

(I should note that the IP, broadcast and MAC addresses are all zeros, even though networking is configured on the system. Not sure if that is relevant. That may be a VirtualBox issue.)

jmd@debian:~$ ola_dev_info
Device 1: Dummy Device
port 0, OUT Dummy Port, patched to universe 7, RDM supported
Device 2: KiNet Device
Device 3: OSC Device
port 0, IN /dmx/universe/%d, priority 100
port 1, IN /dmx/universe/%d, priority 100/
port 2, IN /dmx/universe/%d, priority 100
port 3, IN /dmx/universe/%d, priority 100
port 4, IN /dmx/universe/%d, priority 100
Device 4: Enttec Usb Pro Device
port 0, IN Serial #: 02123447, firmware 4.5, priority 100
port 1, IN Serial #: 02123447, firmware 4.5, priority 100
port 0, OUT Serial #: 02123447, firmware 4.5, patched to universe 1, RDM supported
port 1, OUT Serial #: 02123447, firmware 4.5, patched to universe 2, RDM supported
jmd@debian:~$

There are universes available to select in RDM Tests & Publisher. Not even #7 which has the dummy device assigned to it.

As far as the logs go:

root@debian:/var/log# /etc/init.d/olad status
● olad.service - LSB: OLA daemon
   Loaded: loaded (/etc/init.d/olad)
   Active: active (running) since Tue 2017-04-18 10:25:27 PDT; 37min ago
Process: 428 ExecStart=/etc/init.d/olad start (code=exited, status=0/SUCCESS)
   CGroup: /system.slice/olad.service
           └─447 /usr/bin/olad --syslog --log-level 4 --config-dir /etc/ola

Apr 18 10:25:26 debian olad[428]: Starting OLA daemon: olad.
Apr 18 10:25:27 debian systemd[1]: Started LSB: OLA daemon.
root@debian:/var/log#

root@debian:/var/log# /etc/init.d/rdm_test_server status
● rdm_test_server.service - LSB: OLA RDM Test Server
   Loaded: loaded (/etc/init.d/rdm_test_server)
   Active: active (running) since Tue 2017-04-18 10:25:27 PDT; 38min ago
Process: 459 ExecStart=/etc/init.d/rdm_test_server start (code=exited, status=0/SUCCESS)
   CGroup: /system.slice/rdm_test_server.service
           └─483 /usr/bin/python /usr/bin/rdm_test_server.py --world-writeabl...

Apr 18 10:25:27 debian rdm_test_server[459]: Starting OLA RDM Test Server: r....
Apr 18 10:25:27 debian systemd[1]: Started LSB: OLA RDM Test Server.
Hint: Some lines were ellipsized, use -l to show in full.
root@debian:/var/log#

Nothing interesting in syslog:

root@debian:/var/log# grep olad syslog
Apr 18 10:25:26 debian olad[428]: Starting OLA daemon: olad.

Perhaps I should build the current versions of OLA & RDM Test rather than use the packages that were available for debian with apt-get?

Peter Newman

unread,

Apr 18, 2017, 7:41:11 PM4/18/17

to RDM Testing

Comments inline.

On Wednesday, 19 April 2017 00:27:49 UTC+1, josephmdupre wrote:

Two things I just noticed:

1) I have no /dev/dmx0, even though this is defined in ola-opendmx.conf.

That's a different plugin, we're using Serial USB for Enttec Pro:
https://www.openlighting.org/ola/get-help/ola-faq/#What_is_the_difference_between_the_different_USB_plugins

2) When the Enttec box is attached (i.e the USB port is "Captured" by the VM) it sends out a DISC_UN_MUTE, but that is all-- no DISC_UNIQUE_BRANCH. But this is independent of OLA. When discovery is attempted from OLA Admin, there is no RDM output from the Enttec box.

OLA does background discovery, you could try ola_rdm_discover to force a full discovery (or I think there may be button on the web UI too).

In answer to your questions:

On the OLA Admin New Universe screen, there are 4 listings for the Enttec Usb Pro Device:

Enttec Usb Pro Device     Input     Serial#:02123447, firmware 4.5
Enttec Usb Pro Device     Input     Serial#:02123447, firmware 4.5
Enttec Usb Pro Device     Output    Serial#:02123447, firmware 4.5
Enttec Usb Pro Device     Output    Serial#:02123447, firmware 4.5

(There is no port number per entry displayed which I thought was strange.)

That's fixed in a later version

If I assign an output to a universe it gets removed from that list.

On the Home screen:
Universe #     Universe Name     Input Ports     Output Ports     RDM Devices
1              test#1            0               1                0
2              Test#2            0   1                0
7              Dummy             0               1              6

(I should note that the IP, broadcast and MAC addresses are all zeros, even though networking is configured on the system. Not sure if that is relevant. That may be a VirtualBox issue.)

Interesting, and possibly a bug that needs fixing, but not relevant to this specific issue.

jmd@debian:~$ ola_dev_info
Device 1: Dummy Device
port 0, OUT Dummy Port, patched to universe 7, RDM supported
Device 2: KiNet Device
Device 3: OSC Device
port 0, IN /dmx/universe/%d, priority 100
port 1, IN /dmx/universe/%d, priority 100/
port 2, IN /dmx/universe/%d, priority 100
port 3, IN /dmx/universe/%d, priority 100
port 4, IN /dmx/universe/%d, priority 100
Device 4: Enttec Usb Pro Device
port 0, IN Serial #: 02123447, firmware 4.5, priority 100
port 1, IN Serial #: 02123447, firmware 4.5, priority 100
port 0, OUT Serial #: 02123447, firmware 4.5, patched to universe 1, RDM supported
port 1, OUT Serial #: 02123447, firmware 4.5, patched to universe 2, RDM supported
jmd@debian:~$

There are universes available to select in RDM Tests & Publisher. Not even #7 which has the dummy device assigned to it.

I'm guessing you mean there are NO universes available? That will be part of the issue then, that should appear. That could be down to a few things, but we'll start with some simpler diagnostics with less things in the way.

You need to increase the log level as I mentioned previously to get olad to log all the juicy info.

Perhaps I should build the current versions of OLA & RDM Test rather than use the packages that were available for debian with apt-get?

There are bug fixes in the later versions, but I'm not convinced they'll solve this specific issue, as I think it may be config based.

Can you give us the output of:
ola_rdm_discover -u 1 -f -l 4

And:
ola_rdm_discover -u 2 -f -l 4

Both of those will be a start on their own. Ideally we need them along with the -l 4 version of the olad logs.

joseph...@gmail.com

unread,

Apr 19, 2017, 12:48:04 PM4/19/17

to RDM Testing

On Tuesday, April 18, 2017 at 4:41:11 PM UTC-7, Peter Newman wrote:

Can you give us the output of:
ola_rdm_discover -u 1 -f -l 4

And:
ola_rdm_discover -u 2 -f -l 4

jmd@debian:~$ ola_rdm_discover -u 1 -f -l 4
ola_rdm_discover: invalid option -- 'l'

jmd@debian:~$ ola_rdm_discover -u 1 -f --log-level 4
ola_rdm_discover: unrecognized option '--log-level'

Running the command without -l produces no output and "hangs" the terminal.

And to clarify: Yes, I meant NO universes appear in the RDM Test Universe drop down list.
And I did set --log-level 4 for olad (by modifying the init.d script) as you can see from this:

root@debian:/var/log# /etc/init.d/olad status
● olad.service - LSB: OLA daemon
   Loaded: loaded (/etc/init.d/olad)
   Active: active (running) since Tue 2017-04-18 10:25:27 PDT; 37min ago
Process: 428 ExecStart=/etc/init.d/olad start (code=exited, status=0/SUCCESS)
   CGroup: /system.slice/olad.service
           └─447 /usr/bin/olad --syslog --log-level 4 --config-dir /etc/ola

Apr 18 10:25:26 debian olad[428]: Starting OLA daemon: olad.
Apr 18 10:25:27 debian systemd[1]: Started LSB: OLA daemon.
root@debian:/var/log#

I'll work on compiling from GIT source rather than using these pre-built versions...

- Joe

Peter Newman

unread,

Apr 19, 2017, 2:26:08 PM4/19/17

to RDM Testing

Thanks for that info and clarification.

I'd try running this before you get into trying to compile, it should log direct to stdout instead:

/usr/bin/olad --log-level 4 --config-dir /etc/ola

joseph...@gmail.com

unread,

Apr 20, 2017, 2:14:13 PM4/20/17

to RDM Testing

Apparently I can't stop the running daemon:

jmd@debian:~$ ps -aux | grep olad
olad       432 0.0 1.0 57828 11288 ?        Sl   09:33   0:00 /usr/bin/olad --syslog --log-level 4 --config-dir /etc/ola
olad       462 0.3 1.5 37736 15560 ?        Sl   09:33   0:01 /usr/bin/python /usr/bin/rdm_test_server.py --world-writeable
jmd       1398 4.0 0.2   4560 2340 pts/0    R+   09:37   0:00 grep olad
jmd@debian:~$ sudo /etc/init.d/rdm_test_server stop
[sudo] password for jmd:
[ ok ] Stopping rdm_test_server (via systemctl): rdm_test_server.service.
jmd@debian:~$ sudo /etc/init.d/olad stop
[ ok ] Stopping olad (via systemctl): olad.service.
jmd@debian:~$ ps -aux | grep olad
olad       432 0.0 1.0 57828 11288 ?        Sl   09:33   0:00 /usr/bin/olad --syslog --log-level 4 --config-dir /etc/ola
olad       462 0.3 1.5 37736 15560 ?        Sl   09:33   0:01 /usr/bin/python /usr/bin/rdm_test_server.py --world-writeable
jmd       1461 0.0 0.2   4560 2196 pts/0    S+   09:38   0:00 grep olad
jmd@debian:~$ /usr/bin/olad --log-level 4 --config-dir /etc/ola
Olad.cpp:84: OLA Daemon version 0.9.1
OlaDaemon.cpp:114: Using configs in /etc/ola
TCPSocket.cpp:223: bind to 127.0.0.1:9010 failed, Address already in use
OlaDaemon.cpp:127: Could not listen on the RPC port, you probably have another instance of olad running

This worked:

jmd@debian:~$ sudo systemctl mask rdm_test_server
Created symlink from /etc/systemd/system/rdm_test_server.service to /dev/null.
jmd@debian:~$ sudo systemctl mask olad
Created symlink from /etc/systemd/system/olad.service to /dev/null.
jmd@debian:~$
[REBOOT]

Having trouble copying the debug output, just a second...

Peter Newman

unread,

Apr 20, 2017, 2:28:19 PM4/20/17

to RDM Testing

How odd. I guess your pid files are pointing to the wrong place or have the wrong value or something.

joseph...@gmail.com

unread,

Apr 20, 2017, 2:41:56 PM4/20/17

to RDM Testing

So, when I start olad manually with

jmd@debian:~$ /usr/bin/olad --log-level 4 --config-dir /etc/ola

OLA Admin no longer has the universes I set up for the Enttec box, apparently because it doesn't recognize it. (The Enttec ports are not available when I try to add a universe. From the following log, it looks like this may be a permissions issue with ttyUSB0:

jmd@debian:~$ /usr/bin/olad --log-level 4 --config-dir /etc/ola
Olad.cpp:84: OLA Daemon version 0.9.1
OlaDaemon.cpp:114: Using configs in /etc/ola

PidStoreLoader.cpp:203: Loading BACKGROUND_QUEUED_STATUS_POLICY
PidStoreLoader.cpp:203: Loading BACKGROUND_QUEUED_STATUS_POLICY_DESCRIPTION
PidStoreLoader.cpp:203: Loading BACKGROUND_STATUS_TYPE
PidStoreLoader.cpp:203: Loading QUEUED_STATUS_ENDPOINT_COLLECTION
PidStoreLoader.cpp:203: Loading QUEUED_STATUS_UID_COLLECTION
PidStoreLoader.cpp:203: Loading ENDPOINT_LIST
PidStoreLoader.cpp:203: Loading ENDPOINT_TO_UNIVERSE
PidStoreLoader.cpp:203: Loading RDM_TRAFFIC_ENABLE
PidStoreLoader.cpp:203: Loading ENDPOINT_MODE
PidStoreLoader.cpp:203: Loading ENDPOINT_LABEL
PidStoreLoader.cpp:203: Loading DISCOVERY_STATE
PidStoreLoader.cpp:203: Loading ENDPOINT_TIMING
PidStoreLoader.cpp:203: Loading ENDPOINT_TIMING_DESCRIPTION
PidStoreLoader.cpp:203: Loading BINDING_CONTROL_FIELDS
PidStoreLoader.cpp:203: Loading ENDPOINT_IDENTIFY
PidStoreLoader.cpp:203: Loading BACKGROUND_DISCOVERY
PidStoreLoader.cpp:203: Loading ENDPOINT_DEVICE_LIST_CHANGE
PidStoreLoader.cpp:203: Loading ENDPOINT_DEVICES
PidStoreLoader.cpp:203: Loading TCP_COMMS_STATUS
PidStoreLoader.cpp:203: Loading ENDPOINT_LIST_CHANGE
PidStoreLoader.cpp:203: Loading LIST_INTERFACES
PidStoreLoader.cpp:203: Loading INTERFACE_LABEL
PidStoreLoader.cpp:203: Loading INTERFACE_HARDWARE_ADDRESS_TYPE1
PidStoreLoader.cpp:203: Loading IPV4_DHCP_MODE
PidStoreLoader.cpp:203: Loading IPV4_ZEROCONF_MODE
PidStoreLoader.cpp:203: Loading IPV4_CURRENT_ADDRESS
PidStoreLoader.cpp:203: Loading IPV4_STATIC_ADDRESS
PidStoreLoader.cpp:203: Loading INTERFACE_RENEW_DHCP
PidStoreLoader.cpp:203: Loading INTERFACE_RELEASE_DHCP
PidStoreLoader.cpp:203: Loading INTERFACE_APPLY_CONFIGURATION
PidStoreLoader.cpp:203: Loading IPV4_DEFAULT_ROUTE
PidStoreLoader.cpp:203: Loading DNS_IPV4_NAME_SERVER
PidStoreLoader.cpp:203: Loading DNS_HOSTNAME
PidStoreLoader.cpp:203: Loading DNS_DOMAIN_NAME
PidStoreLoader.cpp:203: Loading DISC_UNIQUE_BRANCH
PidStoreLoader.cpp:203: Loading DISC_MUTE
PidStoreLoader.cpp:203: Loading DISC_UN_MUTE
PidStoreLoader.cpp:203: Loading PROXIED_DEVICES
PidStoreLoader.cpp:203: Loading PROXIED_DEVICE_COUNT
PidStoreLoader.cpp:203: Loading COMMS_STATUS
PidStoreLoader.cpp:203: Loading QUEUED_MESSAGE
PidStoreLoader.cpp:203: Loading STATUS_MESSAGES
PidStoreLoader.cpp:203: Loading STATUS_ID_DESCRIPTION
PidStoreLoader.cpp:203: Loading CLEAR_STATUS_ID
PidStoreLoader.cpp:203: Loading SUB_DEVICE_STATUS_REPORT_THRESHOLD
PidStoreLoader.cpp:203: Loading SUPPORTED_PARAMETERS
PidStoreLoader.cpp:203: Loading PARAMETER_DESCRIPTION
PidStoreLoader.cpp:203: Loading DEVICE_INFO
PidStoreLoader.cpp:203: Loading PRODUCT_DETAIL_ID_LIST
PidStoreLoader.cpp:203: Loading DEVICE_MODEL_DESCRIPTION
PidStoreLoader.cpp:203: Loading MANUFACTURER_LABEL
PidStoreLoader.cpp:203: Loading DEVICE_LABEL
PidStoreLoader.cpp:203: Loading FACTORY_DEFAULTS
PidStoreLoader.cpp:203: Loading LANGUAGE_CAPABILITIES
PidStoreLoader.cpp:203: Loading LANGUAGE
PidStoreLoader.cpp:203: Loading SOFTWARE_VERSION_LABEL
PidStoreLoader.cpp:203: Loading BOOT_SOFTWARE_VERSION_ID
PidStoreLoader.cpp:203: Loading BOOT_SOFTWARE_VERSION_LABEL
PidStoreLoader.cpp:203: Loading DMX_PERSONALITY
PidStoreLoader.cpp:203: Loading DMX_PERSONALITY_DESCRIPTION
PidStoreLoader.cpp:203: Loading DMX_START_ADDRESS
PidStoreLoader.cpp:203: Loading SLOT_INFO
PidStoreLoader.cpp:203: Loading SLOT_DESCRIPTION
PidStoreLoader.cpp:203: Loading DEFAULT_SLOT_VALUE
PidStoreLoader.cpp:203: Loading DMX_BLOCK_ADDRESS
PidStoreLoader.cpp:203: Loading DMX_FAIL_MODE
PidStoreLoader.cpp:203: Loading DMX_STARTUP_MODE
PidStoreLoader.cpp:203: Loading SENSOR_DEFINITION
PidStoreLoader.cpp:203: Loading SENSOR_VALUE
PidStoreLoader.cpp:203: Loading RECORD_SENSORS
PidStoreLoader.cpp:203: Loading DIMMER_INFO
PidStoreLoader.cpp:203: Loading MINIMUM_LEVEL
PidStoreLoader.cpp:203: Loading MAXIMUM_LEVEL
PidStoreLoader.cpp:203: Loading CURVE
PidStoreLoader.cpp:203: Loading CURVE_DESCRIPTION
PidStoreLoader.cpp:203: Loading OUTPUT_RESPONSE_TIME
PidStoreLoader.cpp:203: Loading OUTPUT_RESPONSE_TIME_DESCRIPTION
PidStoreLoader.cpp:203: Loading MODULATION_FREQUENCY
PidStoreLoader.cpp:203: Loading MODULATION_FREQUENCY_DESCRIPTION
PidStoreLoader.cpp:203: Loading DEVICE_HOURS
PidStoreLoader.cpp:203: Loading LAMP_HOURS
PidStoreLoader.cpp:203: Loading LAMP_STRIKES
PidStoreLoader.cpp:203: Loading LAMP_STATE
PidStoreLoader.cpp:203: Loading LAMP_ON_MODE
PidStoreLoader.cpp:203: Loading DEVICE_POWER_CYCLES
PidStoreLoader.cpp:203: Loading BURN_IN
PidStoreLoader.cpp:203: Loading DISPLAY_INVERT
PidStoreLoader.cpp:203: Loading DISPLAY_LEVEL
PidStoreLoader.cpp:203: Loading PAN_INVERT
PidStoreLoader.cpp:203: Loading TILT_INVERT
PidStoreLoader.cpp:203: Loading PAN_TILT_SWAP
PidStoreLoader.cpp:203: Loading REAL_TIME_CLOCK
PidStoreLoader.cpp:203: Loading LOCK_PIN
PidStoreLoader.cpp:203: Loading LOCK_STATE
PidStoreLoader.cpp:203: Loading LOCK_STATE_DESCRIPTION
PidStoreLoader.cpp:203: Loading IDENTIFY_DEVICE
PidStoreLoader.cpp:203: Loading RESET_DEVICE
PidStoreLoader.cpp:203: Loading POWER_STATE
PidStoreLoader.cpp:203: Loading PERFORM_SELFTEST
PidStoreLoader.cpp:203: Loading SELF_TEST_DESCRIPTION
PidStoreLoader.cpp:203: Loading CAPTURE_PRESET
PidStoreLoader.cpp:203: Loading PRESET_PLAYBACK
PidStoreLoader.cpp:203: Loading IDENTIFY_MODE
PidStoreLoader.cpp:203: Loading PRESET_INFO
PidStoreLoader.cpp:203: Loading PRESET_STATUS
PidStoreLoader.cpp:203: Loading PRESET_MERGEMODE
PidStoreLoader.cpp:203: Loading POWER_ON_SELF_TEST
PidStoreLoader.cpp:203: Loading DEVICE_MODE
PidStoreLoader.cpp:203: Loading FAN_MODE
PidStoreLoader.cpp:203: Loading STATUS_LEDS
PidStoreLoader.cpp:203: Loading CCT_ADJUST
PidStoreLoader.cpp:203: Loading GN_ADJUST
PidStoreLoader.cpp:203: Loading DMX_SIGNAL_LOSS_MODE
PidStoreLoader.cpp:203: Loading SHOW_ID
PidStoreLoader.cpp:203: Loading OUTPUT_POWER
PidStoreLoader.cpp:203: Loading HOP_PATTERN
PidStoreLoader.cpp:203: Loading BANDWIDTH
PidStoreLoader.cpp:203: Loading NUM_OF_CHANNELS
PidStoreLoader.cpp:203: Loading LEVEL_TEST
PidStoreLoader.cpp:203: Loading CURVE
PidStoreLoader.cpp:203: Loading BUMP_ENABLED
PidStoreLoader.cpp:203: Loading DATA_LOSS_TIMEOUT
PidStoreLoader.cpp:203: Loading BACKLIGHT_TIMEOUT
PidStoreLoader.cpp:203: Loading RDM_PROXY_ENABLED
PidStoreLoader.cpp:203: Loading INPUT_FORMAT
PidStoreLoader.cpp:203: Loading IP_ADDRESS
PidStoreLoader.cpp:203: Loading IP_SUBNET_MASK
PidStoreLoader.cpp:203: Loading IP_GATEWAY
PidStoreLoader.cpp:203: Loading DHCP_MODE
PidStoreLoader.cpp:203: Loading MAC_ADDRESS
PidStoreLoader.cpp:203: Loading SET_UID
PidStoreLoader.cpp:203: Loading DMX_OUTPUT_STANDARD
PidStoreLoader.cpp:203: Loading ADD_DISCOVERY
PidStoreLoader.cpp:203: Loading DMX_INTERSLOT_TIME
PidStoreLoader.cpp:203: Loading LATENCY
PidStoreLoader.cpp:203: Loading FACTORY_SETTINGS_LOCK
PidStoreLoader.cpp:203: Loading DMX_RDM_INTERLEAVE
PidStoreLoader.cpp:203: Loading PROXIED_DEVICES_ENHANCED
PidStoreLoader.cpp:203: Loading ADAPTIVE_ON_OFF
PidStoreLoader.cpp:203: Loading PWRUP_TEST
PidStoreLoader.cpp:203: Loading INTERNAL_STATS
PidStoreLoader.cpp:203: Loading NE_FAULT_DETECT_MODE
PidStoreLoader.cpp:203: Loading DMX_PROTECT_MODE
PidStoreLoader.cpp:203: Loading DMX_LOSS_MODE
PidStoreLoader.cpp:203: Loading PREHEAT_LEVEL
PidStoreLoader.cpp:203: Loading OUTPUT_CAP_VALUE
PidStoreLoader.cpp:203: Loading DMX_TERM_MODE
PidStoreLoader.cpp:203: Loading FULL_DISCOVERY
PidStoreLoader.cpp:203: Loading OUTPUT_DEFAULT_VALUE
PidStoreLoader.cpp:203: Loading DALI_FADE_TIME
PidStoreLoader.cpp:203: Loading INCREMENTAL_DISCOVERY_INTERVAL
PidStoreLoader.cpp:203: Loading ACK_TIMER_FACTOR
PidStoreLoader.cpp:203: Loading MDG_NETWORK_UNIVERSE_NUMBER
PidStoreLoader.cpp:203: Loading MDG_NETWORK_UNIVERSE_NAME
PidStoreLoader.cpp:203: Loading MDG_GENERATOR_STATE
PidStoreLoader.cpp:203: Loading DMX_LAMP_OFF_ENABLE
PidStoreLoader.cpp:203: Loading DMX_RESET_ENABLE
PidStoreLoader.cpp:203: Loading MCX_LAMP_OFF_ENABLE
PidStoreLoader.cpp:203: Loading STAND_ALONE_OPERATION_ENABLE
PidStoreLoader.cpp:203: Loading SYNCHRONIZED
PidStoreLoader.cpp:203: Loading AUTO_PROGRAM_ENABLE
PidStoreLoader.cpp:203: Loading ENABLE_TIMERS
PidStoreLoader.cpp:203: Loading TIMER1_START_TIME
PidStoreLoader.cpp:203: Loading TIMER1_END_TIME
PidStoreLoader.cpp:203: Loading TIMER2_START_TIME
PidStoreLoader.cpp:203: Loading TIMER2_END_TIME
PidStoreLoader.cpp:203: Loading LIGHTSENSOR_LEVEL_TRIGGER_ENABLE
PidStoreLoader.cpp:203: Loading CAPTURE_CURRENT_SENSOR_VALUE
PidStoreLoader.cpp:203: Loading LIGHTSENSOR_TRIGGER_LEVEL
PidStoreLoader.cpp:203: Loading ADD_SCENE
PidStoreLoader.cpp:203: Loading INSERT_SCENE
PidStoreLoader.cpp:203: Loading STORE_SCENE
PidStoreLoader.cpp:203: Loading DELETE_SCENE
PidStoreLoader.cpp:203: Loading DELETE_ALL_SCENES
PidStoreLoader.cpp:203: Loading NEXT_SCENE
PidStoreLoader.cpp:203: Loading PREVIOUS_SCENE
PidStoreLoader.cpp:203: Loading SCENE_SETTINGS
PidStoreLoader.cpp:203: Loading RUN_PROGRAM
PidStoreLoader.cpp:203: Loading SCENE_NUMBER
PidStoreLoader.cpp:203: Loading SCENE_WAIT_TIME
PidStoreLoader.cpp:203: Loading SCENE_FADE_TIME
PidStoreLoader.cpp:203: Loading SCENE_INTENSITY
PidStoreLoader.cpp:203: Loading SCENE_CYAN
PidStoreLoader.cpp:203: Loading SCENE_MAGENTA
PidStoreLoader.cpp:203: Loading SCENE_YELLOW
PidStoreLoader.cpp:203: Loading SCENE_RED
PidStoreLoader.cpp:203: Loading SCENE_GREEN
PidStoreLoader.cpp:203: Loading SCENE_BLUE
PidStoreLoader.cpp:203: Loading SCENE_AMBER
PidStoreLoader.cpp:203: Loading SCENE_WHITE
PidStoreLoader.cpp:203: Loading SCENE_ZOOM
PidStoreLoader.cpp:203: Loading SCENE_FOCUS
PidStoreLoader.cpp:203: Loading SCENE_RANDOM_COLOR
PidStoreLoader.cpp:203: Loading SCENE_COLOR_WHEEL
PidStoreLoader.cpp:203: Loading SCENE_GOBO_SELECTION
PidStoreLoader.cpp:203: Loading SCENE_GOBO_INDEXING
PidStoreLoader.cpp:203: Loading SCENE_ANIMATION_POSITION
PidStoreLoader.cpp:203: Loading SCENE_ANIMATION_INDEXING
PidStoreLoader.cpp:203: Loading SCENE_GET_DMX
PidStoreLoader.cpp:203: Loading SCENE_FROST_ENABLE
PidStoreLoader.cpp:203: Loading AUTO_SHUTTER_BO_ENABLE
PidStoreLoader.cpp:203: Loading EFFECT_SPEED
PidStoreLoader.cpp:203: Loading EFFECT_SHORTCUTS_ENABLE
PidStoreLoader.cpp:203: Loading EFFECT_FEEDBACK_ENABLE
PidStoreLoader.cpp:203: Loading LAMP_HOUR_WARNING_ENABLE
PidStoreLoader.cpp:203: Loading LAMP_HOUR_WARNING_HOURS
PidStoreLoader.cpp:203: Loading AIR_FILTER_HOUR
PidStoreLoader.cpp:203: Loading AIR_FILTER_HOUR_WARNING_HOURS
PidStoreLoader.cpp:203: Loading DISPLAY_ERRORS_ENABLE
PidStoreLoader.cpp:203: Loading LAMP_ERROR_TEST_ENABLE
PidStoreLoader.cpp:203: Loading SAVE_CUSTOM_CONFIGURATION
PidStoreLoader.cpp:203: Loading LOAD_CUSTOM_CONFIGURATION
PidStoreLoader.cpp:203: Loading BARNDOOR_SOFTWARE_VERSION
PidStoreLoader.cpp:203: Loading CMY_BLACKOUT_ENABLE
PidStoreLoader.cpp:203: Loading TRACKING_MODE
PidStoreLoader.cpp:203: Loading TRACKING_CAL
PidStoreLoader.cpp:203: Loading DIMMER_CURVE
PidStoreLoader.cpp:203: Loading FOCUS_TRACKING
PidStoreLoader.cpp:203: Loading DISPLAY_AUTO_OFF
PidStoreLoader.cpp:203: Loading LAMP_PREHEAT_ENABLE
PidStoreLoader.cpp:203: Loading LAMP_PREHEAT_VALUE
PidStoreLoader.cpp:203: Loading LAMP_POWER_ENABLE
PidStoreLoader.cpp:203: Loading LAMP_POWER_VALUE
PidStoreLoader.cpp:203: Loading IRIS_BLACKOUT_ENABLE
PidStoreLoader.cpp:203: Loading COLOR_WHEEL_BLACKOUT_ENABLE
PidStoreLoader.cpp:203: Loading STUDIO_MODE
PidStoreLoader.cpp:203: Loading BLOCK_TEMP_SETTING
PidStoreLoader.cpp:203: Loading PAN_TILT_SPEED
PidStoreLoader.cpp:203: Loading PAN_TILT_MOVE_ON_RESET_ENABLE
PidStoreLoader.cpp:203: Loading PAN_TILT_LIMITATION_ENABLE
PidStoreLoader.cpp:203: Loading PAN_LIMITATION_MINIMUM
PidStoreLoader.cpp:203: Loading PAN_LIMITATION_MAXIMUM
PidStoreLoader.cpp:203: Loading TILT_LIMITATION_MINIMUM
PidStoreLoader.cpp:203: Loading TILT_LIMITATION_MAXIMUM
PidStoreLoader.cpp:203: Loading PAN_TILT_LIMITATION_AREA
PidStoreLoader.cpp:203: Loading FOLLOW_SPOT_MODE_ENABLE
PidStoreLoader.cpp:203: Loading FOLLOW_SPOT_MODE_LOCK_TOGGLE
PidStoreLoader.cpp:203: Loading FOLLOW_SPOT_MODE_LOCK_PAN
PidStoreLoader.cpp:203: Loading FOLLOW_SPOT_MODE_LOCK_TILT
PidStoreLoader.cpp:203: Loading REGULATE_LAMP_FAN
PidStoreLoader.cpp:203: Loading REGULATE_GOBO_FAN
PidStoreLoader.cpp:203: Loading LAMP_COOLING
PidStoreLoader.cpp:203: Loading FAN_CLEAN
PidStoreLoader.cpp:203: Loading FAN_MODE
PidStoreLoader.cpp:203: Loading SERIAL_NUMBER
PidStoreLoader.cpp:203: Loading EVENT_LOG_USER_EVENT_TRIGGER
PidStoreLoader.cpp:203: Loading DMX_HOLD_MODE
PidStoreLoader.cpp:203: Loading SLOT_LABELS
PidStoreLoader.cpp:203: Loading MODIFY_SENSOR_DEFINITION
PidStoreLoader.cpp:203: Loading NETWORK_ADDRESS
PidStoreLoader.cpp:203: Loading NETWORK_MASK
PidStoreLoader.cpp:203: Loading GATEWAY_ADDRESS
PidStoreLoader.cpp:203: Loading DNS_ADDRESS
PidStoreLoader.cpp:203: Loading DC_OFFSET
PidStoreLoader.cpp:203: Loading DC_FADER_OFFSET
PidStoreLoader.cpp:203: Loading DC_CALIBRATION
PidStoreLoader.cpp:203: Loading CURVE_DEFINITION
PidStoreLoader.cpp:203: Loading ETC_LED_CURVE
PidStoreLoader.cpp:203: Loading ETC_LED_CURVE_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_LED_STROBE
PidStoreLoader.cpp:203: Loading ETC_LED_OUTPUT_MODE
PidStoreLoader.cpp:203: Loading ETC_LED_OUTPUT_MODE_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_LED_RED_SHIFT
PidStoreLoader.cpp:203: Loading ETC_LED_WHITE_POINT
PidStoreLoader.cpp:203: Loading ETC_LED_WHITE_POINT_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_LED_FREQUENCY
PidStoreLoader.cpp:203: Loading ETC_DMX_LOSS_BEHAVIOR
PidStoreLoader.cpp:203: Loading ETC_DMX_LOSS_BEHAVIOR_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_LED_PLUS_SEVEN
PidStoreLoader.cpp:203: Loading ETC_BACKLIGHT_BRIGHTNESS
PidStoreLoader.cpp:203: Loading ETC_BACKLIGHT_TIMEOUT
PidStoreLoader.cpp:203: Loading ETC_STATUS_INDICATORS
PidStoreLoader.cpp:203: Loading ETC_RECALIBRATE_FIXTURE
PidStoreLoader.cpp:203: Loading ETC_OVER_TEMP_MODE
PidStoreLoader.cpp:203: Loading ETC_SIMPLE_SETUP_MODE
PidStoreLoader.cpp:203: Loading ETC_LED_STROBE_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_LED_RED_SHIFT_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_LED_PLUS_SEVEN_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_BACKLIGHT_TIMEOUT_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_SIMPLE_SETUP_MODE_DESCRIPTION
PidStoreLoader.cpp:203: Loading ETC_PREPARE_FOR_SOFTWARE_DOWNLOAD
PidStoreLoader.cpp:203: Loading SERIAL_NUMBER
PidStoreLoader.cpp:203: Loading CODE_VERSION
PidStoreLoader.cpp:179: Load Complete
OlaServer.cpp:494: Updated PID definitions.
PosixInterfacePicker.cpp:157: skipping lo because it's a loopback
PosixInterfacePicker.cpp:236: Found: eth0, 10.0.2.15, 08:00:27:b2:db:2f
InterfacePicker.cpp:92: Using interface eth0 (10.0.2.15)
OlaServer.cpp:212: Server UID is 7a70:0f02000a
HTTPServer.cpp:463: HTTP Server started on port 9090
HTTPServer.cpp:566: Adding 17 as a new socket
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001
PluginManager.cpp:77: Skipping FTDI USB DMX because it was disabled
PluginManager.cpp:77: Skipping UART native DMX because it was disabled
PluginManager.cpp:108: Trying to start ArtNet
PosixInterfacePicker.cpp:157: skipping lo because it's a loopback
PosixInterfacePicker.cpp:236: Found: eth0, 10.0.2.15, 08:00:27:b2:db:2f
InterfacePicker.cpp:92: Using interface eth0 (10.0.2.15)
Socket.cpp:143: Binding to 0.0.0.0:6454
DeviceManager.cpp:116: Installed device: ArtNet [10.0.2.15]:2-1
PluginManager.cpp:112: Started ArtNet
PluginManager.cpp:108: Trying to start Dummy
DeviceManager.cpp:116: Installed device: Dummy Device:1-1
PortManager.cpp:154: Patched 1-1-O-0 to universe 7
PluginManager.cpp:112: Started Dummy
PluginManager.cpp:108: Trying to start E1.31 (sACN)
PosixInterfacePicker.cpp:157: skipping lo because it's a loopback
PosixInterfacePicker.cpp:236: Found: eth0, 10.0.2.15, 08:00:27:b2:db:2f
InterfacePicker.cpp:92: Using interface eth0 (10.0.2.15)
Socket.cpp:143: Binding to 0.0.0.0:5568
DeviceManager.cpp:116: Installed device: E1.31 (DMX over ACN) [10.0.2.15]:11-1
PluginManager.cpp:112: Started E1.31 (sACN)
PluginManager.cpp:108: Trying to start ESP Net
PosixInterfacePicker.cpp:157: skipping lo because it's a loopback
PosixInterfacePicker.cpp:236: Found: eth0, 10.0.2.15, 08:00:27:b2:db:2f
InterfacePicker.cpp:92: Using interface eth0 (10.0.2.15)
Socket.cpp:143: Binding to 0.0.0.0:3333
DeviceManager.cpp:116: Installed device: ESP Net [10.0.2.15]:4-1
PluginManager.cpp:112: Started ESP Net
PluginManager.cpp:108: Trying to start KarateLight
IOUtils.cpp:38: Failed to open /dev/kldmx0: No such file or directory
KaratePlugin.cpp:79: Could not open /dev/kldmx0 No such file or directory
PluginManager.cpp:112: Started KarateLight
PluginManager.cpp:108: Trying to start KiNET
Socket.cpp:143: Binding to 0.0.0.0:6038
DeviceManager.cpp:116: Installed device: KiNet Device:16-1
PluginManager.cpp:112: Started KiNET
PluginManager.cpp:108: Trying to start Milford Instruments
MilInstPlugin.cpp:57: No path configured for device, please set one in ola-milinst.conf
PluginManager.cpp:112: Started Milford Instruments
PluginManager.cpp:108: Trying to start Enttec Open DMX
IOUtils.cpp:38: Failed to open /dev/dmx0: No such file or directory
OpenDmxPlugin.cpp:80: Could not open /dev/dmx0 No such file or directory
PluginManager.cpp:112: Started Enttec Open DMX
PluginManager.cpp:108: Trying to start OSC
OSCDevice.cpp:88: No targets specified for OSC Output port 0
OSCDevice.cpp:88: No targets specified for OSC Output port 1
OSCDevice.cpp:88: No targets specified for OSC Output port 2
OSCDevice.cpp:88: No targets specified for OSC Output port 3
OSCDevice.cpp:88: No targets specified for OSC Output port 4
DeviceManager.cpp:116: Installed device: OSC Device:14-1
PluginManager.cpp:112: Started OSC
PluginManager.cpp:108: Trying to start Renard
RenardPlugin.cpp:57: No path configured for device, please set one in ola-renard.conf
PluginManager.cpp:112: Started Renard
PluginManager.cpp:108: Trying to start SandNet
PosixInterfacePicker.cpp:157: skipping lo because it's a loopback
PosixInterfacePicker.cpp:236: Found: eth0, 10.0.2.15, 08:00:27:b2:db:2f
InterfacePicker.cpp:92: Using interface eth0 (10.0.2.15)
Socket.cpp:143: Binding to 0.0.0.0:37895
Socket.cpp:143: Binding to 0.0.0.0:37900
DeviceManager.cpp:116: Installed device: SandNet [10.0.2.15]:7-1
PluginManager.cpp:112: Started SandNet
PluginManager.cpp:108: Trying to start ShowNet
PosixInterfacePicker.cpp:157: skipping lo because it's a loopback
PosixInterfacePicker.cpp:236: Found: eth0, 10.0.2.15, 08:00:27:b2:db:2f
InterfacePicker.cpp:92: Using interface eth0 (10.0.2.15)
Socket.cpp:143: Binding to 0.0.0.0:2501
DeviceManager.cpp:116: Installed device: ShowNet [10.0.2.15]:3-1
PluginManager.cpp:112: Started ShowNet
PluginManager.cpp:108: Trying to start SPI
PluginManager.cpp:112: Started SPI
PluginManager.cpp:108: Trying to start StageProfi
IOUtils.cpp:38: Failed to open /dev/ttyUSB0: Permission denied
StageProfiDevice.cpp:79: StageProfiPlugin: failed to connect to /dev/ttyUSB0
PluginManager.cpp:112: Started StageProfi
PluginManager.cpp:108: Trying to start Serial USB
WidgetDetectorThread.cpp:204: Found potential USB Serial device at /dev/ttyUSB0
IOUtils.cpp:38: Failed to open /dev/ttyUSB0: Permission denied
WidgetDetectorThread.cpp:204: Found potential USB Serial device at /dev/ttyUSB0
IOUtils.cpp:38: Failed to open /dev/ttyUSB0: Permission denied
PluginManager.cpp:112: Started Serial USB
PluginManager.cpp:108: Trying to start USB
UsbDmxPlugin.cpp:99: libusb debug level set to 0
PluginManager.cpp:112: Started USB
PluginManager.cpp:108: Trying to start Pathport
PosixInterfacePicker.cpp:157: skipping lo because it's a loopback
PosixInterfacePicker.cpp:236: Found: eth0, 10.0.2.15, 08:00:27:b2:db:2f
InterfacePicker.cpp:92: Using interface eth0 (10.0.2.15)
Socket.cpp:143: Binding to 0.0.0.0:3792
SelectPoller.cpp:160: ss process time was 0.000002
DeviceManager.cpp:116: Installed device: Pathport [10.0.2.15]:9-1
PluginManager.cpp:112: Started Pathport
SelectPoller.cpp:160: ss process time was 0.000002
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
PathportDevice.cpp:144: Sending pathport arp reply
SelectPoller.cpp:160: ss process time was 0.000003
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000005
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000002
PathportDevice.cpp:144: Sending pathport arp reply
SelectPoller.cpp:160: ss process time was 0.000003
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000002
PathportDevice.cpp:144: Sending pathport arp reply
SelectPoller.cpp:160: ss process time was 0.000002
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
WidgetDetectorThread.cpp:204: Found potential USB Serial device at /dev/ttyUSB0
IOUtils.cpp:38: Failed to open /dev/ttyUSB0: Permission denied
WidgetDetectorThread.cpp:204: Found potential USB Serial device at /dev/ttyUSB0
IOUtils.cpp:38: Failed to open /dev/ttyUSB0: Permission denied
SelectPoller.cpp:160: ss process time was 0.000018
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000002
SandNetDevice.cpp:151: Sending Sandnet advertisement
SelectPoller.cpp:160: ss process time was 0.000003
PathportDevice.cpp:144: Sending pathport arp reply

joseph...@gmail.com

unread,

Apr 20, 2017, 2:49:32 PM4/20/17

to RDM Testing

I'm no linux guru, but I thought if I redirected output like so:
jmd@debian:~$ /usr/bin/olad --log-level 4 --config-dir /etc/ola > olad.log
then the olad debug output would get redirected to the log file instead of the screen. But it still goes to the terminal screen and nothing goes to the log file, even after quitting with CTRL-C. Not sure why that doesn't work (unless the log output goes to STDERR?)

- Joe

Peter Newman

unread,

Apr 20, 2017, 5:52:09 PM4/20/17

to RDM Testing

You probably need to run olad as the olad user like it was doing before (sudo -u olad /usr/bin/olad...). The logs are going to STDERR, so you'll need to do 2>&1 > olad.log

joseph...@gmail.com

unread,

Apr 21, 2017, 12:10:37 AM4/21/17

to RDM Testing

Yes, that worked running as user olad. I disabled many of the plugins to remove some clutter.
It appears that an incremental discovery happens as soon as the Enttec plugin loads (without my input).
Log indicates "Un-muting all devices", which my device receives and responds to.
(I have a Saleae Logic analyzer, so I'll capture the request/response and post that later.)
There is nothing in the log that indicates the discovery is proceeding, and my device never gets a DISC_UNIQUE_BRANCH request.

Following is the log file:

Olad.cpp:84: OLA Daemon version 0.9.1
OlaDaemon.cpp:114: Using configs in /etc/ola

PluginManager.cpp:77: Skipping ArtNet because it was disabled
PluginManager.cpp:77: Skipping ESP Net because it was disabled
PluginManager.cpp:77: Skipping KarateLight because it was disabled
PluginManager.cpp:77: Skipping KiNET because it was disabled

SelectPoller.cpp:160: ss process time was 0.000002

PluginManager.cpp:77: Skipping Milford Instruments because it was disabled
PluginManager.cpp:77: Skipping OSC because it was disabled

SelectPoller.cpp:160: ss process time was 0.000001

PluginManager.cpp:77: Skipping Renard because it was disabled
PluginManager.cpp:77: Skipping SandNet because it was disabled
PluginManager.cpp:77: Skipping ShowNet because it was disabled
PluginManager.cpp:77: Skipping SPI because it was disabled
PluginManager.cpp:77: Skipping StageProfi because it was disabled
PluginManager.cpp:77: Skipping Pathport because it was disabled

PluginManager.cpp:77: Skipping FTDI USB DMX because it was disabled
PluginManager.cpp:77: Skipping UART native DMX because it was disabled

PluginManager.cpp:108: Trying to start Dummy
DeviceManager.cpp:116: Installed device: Dummy Device:1-1
PortManager.cpp:154: Patched 1-1-O-0 to universe 7
PluginManager.cpp:112: Started Dummy
PluginManager.cpp:108: Trying to start E1.31 (sACN)
PosixInterfacePicker.cpp:157: skipping lo because it's a loopback
PosixInterfacePicker.cpp:236: Found: eth0, 10.0.2.15, 08:00:27:b2:db:2f
InterfacePicker.cpp:92: Using interface eth0 (10.0.2.15)
Socket.cpp:143: Binding to 0.0.0.0:5568
DeviceManager.cpp:116: Installed device: E1.31 (DMX over ACN) [10.0.2.15]:11-1
PluginManager.cpp:112: Started E1.31 (sACN)

PluginManager.cpp:108: Trying to start Enttec Open DMX
IOUtils.cpp:38: Failed to open /dev/dmx0: No such file or directory
OpenDmxPlugin.cpp:80: Could not open /dev/dmx0 No such file or directory
PluginManager.cpp:112: Started Enttec Open DMX

PluginManager.cpp:108: Trying to start Serial USB
WidgetDetectorThread.cpp:204: Found potential USB Serial device at /dev/ttyUSB0

WidgetDetectorThread.cpp:210: new descriptor @ 0x80b1c48 for /dev/ttyUSB0
WidgetDetectorThread.cpp:373: trying stage 0 for 0x80b1c48

SelectPoller.cpp:160: ss process time was 0.000001

PluginManager.cpp:112: Started Serial USB
PluginManager.cpp:108: Trying to start USB
UsbDmxPlugin.cpp:99: libusb debug level set to 0
PluginManager.cpp:112: Started USB

SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000002

UsbProWidgetDetector.cpp:515: Detected USB Device: ESTA Id: 0x0, device Id: 0, serial: 0x2123447, f/w version: 4.5

SelectPoller.cpp:160: ss process time was 0.000002

WidgetDetectorThread.cpp:304: Defaulting to a Usb Pro device
WidgetDetectorThread.cpp:306: Found and unlocked an Enttec USB Pro Mk II

SelectPoller.cpp:160: ss process time was 0.000001

DeviceManager.cpp:116: Installed device: Enttec Usb Pro Device:5-02123447
EnttecUsbProWidget.cpp:291: Incremental discovery triggered
EnttecUsbProWidget.cpp:324: Un-muting all devices
PortManager.cpp:154: Patched 5-02123447-O-0 to universe 1
EnttecUsbProWidget.cpp:291: Incremental discovery triggered
EnttecUsbProWidget.cpp:324: Un-muting all devices
PortManager.cpp:154: Patched 5-02123447-O-1 to universe 2

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000005
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000006
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000004

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000006
SelectPoller.cpp:160: ss process time was 0.000300
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000005

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000002
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000004
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000120

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000002
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000003
SignalThread.cpp:99: Received signal: Interrupt
HTTPServer.cpp:485: Notifying HTTP server thread to stop
HTTPServer.cpp:487: Waiting for HTTP server thread to exit
HTTPServer.cpp:489: HTTP server thread exited
EnttecUsbProWidget.cpp:605: Enttec Pro discovery complete:
EnttecUsbProWidget.cpp:605: Enttec Pro discovery complete:
jmd@debian:~$

joseph...@gmail.com

unread,

Apr 21, 2017, 1:13:08 AM4/21/17

to RDM Testing

Attached is a Saleae Logic capture of the Enttec un-mute request and my response.
This is all that happens in the "incremental discovery" when olad is started.

Enttec_Unmute-Translyte_Response.logicdata

Peter Newman

unread,

Apr 21, 2017, 9:43:34 AM4/21/17

to RDM Testing

On Friday, 21 April 2017 05:10:37 UTC+1, josephmdupre wrote:

Yes, that worked running as user olad. I disabled many of the plugins to remove some clutter.
It appears that an incremental discovery happens as soon as the Enttec plugin loads (without my input).

Yeah OLA does background discovery by default.

Log indicates "Un-muting all devices", which my device receives and responds to.

Do you mean reacts to? It will be a broadcast message to un-mute them all, and your device shouldn't respond to a broadcast (because it would just cause collisions).

(I have a Saleae Logic analyzer, so I'll capture the request/response and post that later.)
There is nothing in the log that indicates the discovery is proceeding, and my device never gets a DISC_UNIQUE_BRANCH request.

Can you grab logs from our Saleae based RDM sniffer instead (rather than me having to dig through the Logic itself. It'll also decode all the RDM packets:

https://www.openlighting.org/rdm-tools/rdm-analyzers/saleae-logic-sniffer/

http://docs.openlighting.org/ola/man/man1/logic_rdm_sniffer.1.html

On Friday, 21 April 2017 06:13:08 UTC+1, josephmdupre wrote:

Attached is a Saleae Logic capture of the Enttec un-mute request and my response.
This is all that happens in the "incremental discovery" when olad is started.

Given we've got a few variables, potentially an issue with OLA, potentially an issue with your Enttec Pro Mk II and potentially an issue with your responder code, are you able to run this Arduino code, which would help to narrow down what's going on (if that works, or if it fails) https://github.com/mathertel/DmxSerial2 ?

joseph...@gmail.com

unread,

Apr 21, 2017, 12:15:44 PM4/21/17

to RDM Testing

Yeah OLA does background discovery by default.
Log indicates "Un-muting all devices", which my device receives and responds to.
Do you mean reacts to? It will be a broadcast message to un-mute them all, and your device shouldn't respond to a broadcast (because it would just cause collisions).

Hmmm. What you say makes perfect sense, but that is not to spec.
Section 5.3 states "When Broadcast Addressing is used for non-Discovery messages, the responders shall not send a response."

Un-mute and Mute are discovery messages, so I thought a response was required.

Peter Newman

unread,

Apr 21, 2017, 3:01:23 PM4/21/17

to RDM Testing

Hmm, I think that's probably an issue with the standard, see http://www.rdmprotocol.org/forums/showpost.php?p=2977&postcount=8 for some more stuff to back it up. As well as DMX Serial 2 https://github.com/mathertel/DmxSerial2/blob/master/src/DMXSerial2.cpp#L550 .

I suspect that line should actually say non-DUB messages.

Anyway, do you want to change that bit of your code and see if it works?

joseph...@gmail.com

unread,

Apr 25, 2017, 5:52:25 PM4/25/17

to RDM Testing

I changed my code to not reply to broadcast mute/unmute requests as you suggested.
I also got the RDM Integrity test software with a DMXter 4A RDM. My responder has passed all of the normal tests. (I have not put it through the stress tests yet).

Tried again with OLA and the Enttec. Did not change a thing. Enttec sends an unmute, but stops there.

Tried OLA with the DMXter. Still no discovery. I think these debian builds are broken, or there is some problem with the USB communication between the virtual machine and the host.
Anything you'd like me to try before attempting a build from source?
Following is the log:

jmd@debian:~$ sudo -u olad /usr/bin/olad --log-level 4 --config-dir /etc/ola
[sudo] password for jmd:

Olad.cpp:84: OLA Daemon version 0.9.1
OlaDaemon.cpp:114: Using configs in /etc/ola

WidgetDetectorThread.cpp:210: new descriptor @ 0x8ee8c48 for /dev/ttyUSB0
WidgetDetectorThread.cpp:373: trying stage 0 for 0x8ee8c48

SelectPoller.cpp:160: ss process time was 0.000001
PluginManager.cpp:112: Started Serial USB
PluginManager.cpp:108: Trying to start USB

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000002

UsbDmxPlugin.cpp:99: libusb debug level set to 0
PluginManager.cpp:112: Started USB
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000022

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000004
UsbProWidgetDetector.cpp:515: Detected USB Device: ESTA Id: 0x4744 (GODDARD DESIGN), device Id: 3441 (DMXter4A RDM), serial: 0x414400, f/w version: N/A

SelectPoller.cpp:160: ss process time was 0.000001

WidgetDetectorThread.cpp:304: Defaulting to a Usb Pro device

SelectPoller.cpp:160: ss process time was 0.000000
DeviceManager.cpp:116: Installed device: GODDARD DESIGN - DMXter4A RDM:5-00414400

SelectPoller.cpp:160: ss process time was 0.000001

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000005
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000195

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000021

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000006
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000005
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000123

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000005
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000006
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000003
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000005
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000103

SelectPoller.cpp:160: ss process time was 0.000001

HTTPServer.cpp:566: Adding 28 as a new socket
SelectPoller.cpp:160: ss process time was 0.001491
SelectPoller.cpp:160: ss process time was 0.001621
SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000761
SelectPoller.cpp:160: ss process time was 0.000240
SelectPoller.cpp:160: ss process time was 0.000011
SelectPoller.cpp:160: ss process time was 0.000052
SelectPoller.cpp:160: ss process time was 0.000281
SelectPoller.cpp:160: ss process time was 0.000009
SelectPoller.cpp:160: ss process time was 0.000035
SelectPoller.cpp:160: ss process time was 0.002681
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.005628
HTTPServer.cpp:566: Adding 29 as a new socket
SelectPoller.cpp:160: ss process time was 0.000921
SelectPoller.cpp:160: ss process time was 0.000151
SelectPoller.cpp:160: ss process time was 0.000228
SelectPoller.cpp:160: ss process time was 0.000429
SelectPoller.cpp:160: ss process time was 0.000754
SelectPoller.cpp:160: ss process time was 0.000027
SelectPoller.cpp:160: ss process time was 0.000078
SelectPoller.cpp:160: ss process time was 0.000084
SelectPoller.cpp:160: ss process time was 0.000009
SelectPoller.cpp:160: ss process time was 0.000033
SelectPoller.cpp:160: ss process time was 0.000207
SelectPoller.cpp:160: ss process time was 0.000011
SelectPoller.cpp:160: ss process time was 0.000134
SelectPoller.cpp:160: ss process time was 0.000892
SelectPoller.cpp:160: ss process time was 0.000012
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000193
SelectPoller.cpp:160: ss process time was 0.000010
SelectPoller.cpp:160: ss process time was 0.000481
SelectPoller.cpp:160: ss process time was 0.000125
SelectPoller.cpp:160: ss process time was 0.000012
SelectPoller.cpp:160: ss process time was 0.000033
SelectPoller.cpp:160: ss process time was 0.000117
SelectPoller.cpp:160: ss process time was 0.000010
SelectPoller.cpp:160: ss process time was 0.000103

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.014683

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000084
SelectPoller.cpp:160: ss process time was 0.000027
SelectPoller.cpp:160: ss process time was 0.000751

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000497

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007
SelectPoller.cpp:160: ss process time was 0.000052

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000293
SelectPoller.cpp:160: ss process time was 0.000321

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000008
SelectPoller.cpp:160: ss process time was 0.000016

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000244

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000375

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000008
SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000158

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.003824
SelectPoller.cpp:160: ss process time was 0.000008
SelectPoller.cpp:160: ss process time was 0.000022

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000290
SelectPoller.cpp:160: ss process time was 0.000653

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000186

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000005
SelectPoller.cpp:160: ss process time was 0.000370

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000264
SelectPoller.cpp:160: ss process time was 0.000182
SelectPoller.cpp:160: ss process time was 0.000119

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000323
SelectPoller.cpp:160: ss process time was 0.000011
SelectPoller.cpp:160: ss process time was 0.000222

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000733

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000008
SelectPoller.cpp:160: ss process time was 0.000018

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000171

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.003623
SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000020
SelectPoller.cpp:160: ss process time was 0.000182

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000120

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000279

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.003012
SelectPoller.cpp:160: ss process time was 0.000008
SelectPoller.cpp:160: ss process time was 0.000017

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000259

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000095

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000008
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000223

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001837
SelectPoller.cpp:160: ss process time was 0.000009

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000021
SelectPoller.cpp:160: ss process time was 0.000190

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000005
SelectPoller.cpp:160: ss process time was 0.000094

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000146
SelectPoller.cpp:160: ss process time was 0.000513
PortManager.cpp:154: Patched 5-00414400-O-0 to universe 5

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000060
SelectPoller.cpp:160: ss process time was 0.000106

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000103

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000053
SelectPoller.cpp:160: ss process time was 0.000111

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000047
SelectPoller.cpp:160: ss process time was 0.000094

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000342
SelectPoller.cpp:160: ss process time was 0.000098

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001892
SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000169
SelectPoller.cpp:160: ss process time was 0.000308

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000052

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000284
SelectPoller.cpp:160: ss process time was 0.000012
SelectPoller.cpp:160: ss process time was 0.000048
SelectPoller.cpp:160: ss process time was 0.000075
SelectPoller.cpp:160: ss process time was 0.000009
SelectPoller.cpp:160: ss process time was 0.000261
Universe.cpp:273: Added source client, 0x8ede5c8 to universe 5
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.003167
SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000233
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000458

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000033
SelectPoller.cpp:160: ss process time was 0.000059
SelectPoller.cpp:160: ss process time was 0.000373
EnttecUsbProWidget.cpp:139: sending frame with label 6
SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000051
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001676
SelectPoller.cpp:160: ss process time was 0.000025
SelectPoller.cpp:160: ss process time was 0.000200
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000392
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000051
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000105
SelectPoller.cpp:160: ss process time was 0.000292
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000051
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000375
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001038
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.001272
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000093
SelectPoller.cpp:160: ss process time was 0.000010

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000057

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000079
SelectPoller.cpp:160: ss process time was 0.000493
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000734
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000204
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000004
OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000727
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000053
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000356
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001151
SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000162
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000417
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000050
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.002077

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000010
SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000539
SelectPoller.cpp:160: ss process time was 0.000373
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000050
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000685
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000345
SelectPoller.cpp:160: ss process time was 0.000158
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000119
SelectPoller.cpp:160: ss process time was 0.000389
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000153
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000423
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000052
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000079
SelectPoller.cpp:160: ss process time was 0.000610
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000047
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000093

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000036
SelectPoller.cpp:160: ss process time was 0.000056
SelectPoller.cpp:160: ss process time was 0.000662
EnttecUsbProWidget.cpp:139: sending frame with label 6

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000197
EnttecUsbProWidget.cpp:864: Unknown message type 0x6, length 0

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000767

SelectPoller.cpp:160: ss process time was 0.000002

RDMHTTPModule.cpp:834: Adding a new state entry for 5
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000051
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000348

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000108
SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000056
SelectPoller.cpp:160: ss process time was 0.000103

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000073
Universe.cpp:499: Full RDM discovery triggered for universe 5

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.001451
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000224
SelectPoller.cpp:160: ss process time was 0.000094

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000115
SelectPoller.cpp:160: ss process time was 0.000055
SelectPoller.cpp:160: ss process time was 0.000117

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000048
OlaServer.cpp:343: Garbage collecting
Universe.cpp:418: Removed Stale Client

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001249
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000170
SelectPoller.cpp:160: ss process time was 0.000194

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000009

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000055

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.002707

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000008
SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000267
SelectPoller.cpp:160: ss process time was 0.000153

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000053

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001694
SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000194
SelectPoller.cpp:160: ss process time was 0.000111

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000043
SelectPoller.cpp:160: ss process time was 0.000315

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000055

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000003

HTTPServer.cpp:555: Removing 29 as it's not longer needed
SelectPoller.cpp:160: ss process time was 0.000574

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001588

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000015

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000165
SelectPoller.cpp:160: ss process time was 0.000098

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000019
SelectPoller.cpp:160: ss process time was 0.000063

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.002757
SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000230

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000439

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000034
SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000077

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000012
SelectPoller.cpp:160: ss process time was 0.000036
SelectPoller.cpp:160: ss process time was 0.000121

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000007
SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000053

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001832
SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000236
SelectPoller.cpp:160: ss process time was 0.000162

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000037

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000291
Universe.cpp:501: Incremental RDM discovery triggered for universe 5
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.002563
SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000182
SelectPoller.cpp:160: ss process time was 0.000099
Universe.cpp:501: Incremental RDM discovery triggered for universe 5

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000048

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000126

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000047
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000020
SelectPoller.cpp:160: ss process time was 0.002024
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000736
SelectPoller.cpp:160: ss process time was 0.000158

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000250

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000154

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000101

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000096

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000186
SelectPoller.cpp:160: ss process time was 0.000097

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000048

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.002639

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000022
SelectPoller.cpp:160: ss process time was 0.000017

SelectPoller.cpp:160: ss process time was 0.000201
OlaServer.cpp:343: Garbage collecting

SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000377

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000062
SelectPoller.cpp:160: ss process time was 0.000161

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000137
SelectPoller.cpp:160: ss process time was 0.000206

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000056

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000102

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049
SelectPoller.cpp:160: ss process time was 0.000108

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001016
SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000161
SelectPoller.cpp:160: ss process time was 0.000094

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000070

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000007
SelectPoller.cpp:160: ss process time was 0.000096

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000045
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.002881
SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000072
SelectPoller.cpp:160: ss process time was 0.000095
SelectPoller.cpp:160: ss process time was 0.000010

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000019
SelectPoller.cpp:160: ss process time was 0.000062

SelectPoller.cpp:160: ss process time was 0.000001

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000005
SelectPoller.cpp:160: ss process time was 0.000096

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000408
SelectPoller.cpp:160: ss process time was 0.000095

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000159

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001309
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000187
SelectPoller.cpp:160: ss process time was 0.000102

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000057

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000098

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000048
SelectPoller.cpp:160: ss process time was 0.000138

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000009

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000019
SelectPoller.cpp:160: ss process time was 0.000182

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001825
SelectPoller.cpp:160: ss process time was 0.000019
SelectPoller.cpp:160: ss process time was 0.000265
SelectPoller.cpp:160: ss process time was 0.000923

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000008
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000054

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000112

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000550

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000159

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001495
SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000291
SelectPoller.cpp:160: ss process time was 0.000277

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000057

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000128

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000047
SelectPoller.cpp:160: ss process time was 0.000344

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000221
SelectPoller.cpp:160: ss process time was 0.000192

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001305
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000713
SelectPoller.cpp:160: ss process time was 0.000095

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000054

SelectPoller.cpp:160: ss process time was 0.000001

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000102

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000048
SelectPoller.cpp:160: ss process time was 0.000154
SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000055
SelectPoller.cpp:160: ss process time was 0.000096

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000202
SelectPoller.cpp:160: ss process time was 0.000923

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000160

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001265
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000197
SelectPoller.cpp:160: ss process time was 0.000151

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000408
SelectPoller.cpp:160: ss process time was 0.000099

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000151
SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000260

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000098

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000045
SelectPoller.cpp:160: ss process time was 0.000093

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000007
SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049
SelectPoller.cpp:160: ss process time was 0.000455

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000138
SelectPoller.cpp:160: ss process time was 0.000091

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.011429

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000223
SelectPoller.cpp:160: ss process time was 0.000223

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000572

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000045
SelectPoller.cpp:160: ss process time was 0.000149

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000098

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000052

SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.001994
SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000022
SelectPoller.cpp:160: ss process time was 0.000086

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001419
SelectPoller.cpp:160: ss process time was 0.000020
SelectPoller.cpp:160: ss process time was 0.000820
SelectPoller.cpp:160: ss process time was 0.000093
SelectPoller.cpp:160: ss process time was 0.000008

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000052

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000102

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000052
SelectPoller.cpp:160: ss process time was 0.000097

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000009

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000021
SelectPoller.cpp:160: ss process time was 0.000065

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000203

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000049

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000096
SelectPoller.cpp:160: ss process time was 0.000010

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000177
SelectPoller.cpp:160: ss process time was 0.000147

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000047
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000065

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000099

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000414

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000009

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000026
SelectPoller.cpp:160: ss process time was 0.000210
SelectPoller.cpp:160: ss process time was 0.000600
SelectPoller.cpp:160: ss process time was 0.000017

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000198

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.001875

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000422

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000096

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000096

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000073
SelectPoller.cpp:160: ss process time was 0.000074
SelectPoller.cpp:160: ss process time was 0.000100

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000047
SelectPoller.cpp:160: ss process time was 0.000093

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000301
SelectPoller.cpp:160: ss process time was 0.000167

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000170

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000097

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000009
SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000061
SelectPoller.cpp:160: ss process time was 0.000097

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000461

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000150

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000195

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000045
SelectPoller.cpp:160: ss process time was 0.000093

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000150

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001185
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000143
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000327

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000131

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000093

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000048
SelectPoller.cpp:160: ss process time was 0.000460

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000049
SelectPoller.cpp:160: ss process time was 0.000091

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000049

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000476

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049
SelectPoller.cpp:160: ss process time was 0.000091

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000047
SelectPoller.cpp:160: ss process time was 0.000098

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000095

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000327

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000310

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001628

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000016

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000240
SelectPoller.cpp:160: ss process time was 0.000445

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000169
SelectPoller.cpp:160: ss process time was 0.000235
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000049

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000128

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000183
SelectPoller.cpp:160: ss process time was 0.000091

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000038
SelectPoller.cpp:160: ss process time was 0.000172
SelectPoller.cpp:160: ss process time was 0.000100

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000172

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001714
SelectPoller.cpp:160: ss process time was 0.000007
SelectPoller.cpp:160: ss process time was 0.000015

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000246

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000119

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000111

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000051
SelectPoller.cpp:160: ss process time was 0.000140
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000049

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000090

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000080
SelectPoller.cpp:160: ss process time was 0.000048

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000265

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000091

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049
SelectPoller.cpp:160: ss process time was 0.000139

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049
SelectPoller.cpp:160: ss process time was 0.000290

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000156

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000097

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000052
SelectPoller.cpp:160: ss process time was 0.000432

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000056
SelectPoller.cpp:160: ss process time was 0.000115

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000047
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000051

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000167

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000372

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000162

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000960
SelectPoller.cpp:160: ss process time was 0.000017
SelectPoller.cpp:160: ss process time was 0.000164
SelectPoller.cpp:160: ss process time was 0.000090

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000049

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000100

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000105
SelectPoller.cpp:160: ss process time was 0.000090

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000048
SelectPoller.cpp:160: ss process time was 0.000122

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000117
SelectPoller.cpp:160: ss process time was 0.000098

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000018
SelectPoller.cpp:160: ss process time was 0.000061

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000144

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000598
SelectPoller.cpp:160: ss process time was 0.000309

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000139

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.004855
SelectPoller.cpp:160: ss process time was 0.000019
SelectPoller.cpp:160: ss process time was 0.000664
SelectPoller.cpp:160: ss process time was 0.000093

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000055

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001130
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000169
SelectPoller.cpp:160: ss process time was 0.000091

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000099

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000889
SelectPoller.cpp:160: ss process time was 0.000093

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000052

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000100
SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000380
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000068
SelectPoller.cpp:160: ss process time was 0.000131

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000302
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000210

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000046
SelectPoller.cpp:160: ss process time was 0.000316

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000049
SelectPoller.cpp:160: ss process time was 0.000097

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000107
SelectPoller.cpp:160: ss process time was 0.000110

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000155
SelectPoller.cpp:160: ss process time was 0.000054

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000128

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000117
SelectPoller.cpp:160: ss process time was 0.000091

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001563
SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000396
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000141

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000068
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000005

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000358

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000069

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001629

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000172

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000123

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000047
SelectPoller.cpp:160: ss process time was 0.000111

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000357

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.002525
SelectPoller.cpp:160: ss process time was 0.000029
SelectPoller.cpp:160: ss process time was 0.000393
SelectPoller.cpp:160: ss process time was 0.000373

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000051

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000118

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000049
SelectPoller.cpp:160: ss process time was 0.000108

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000050
SelectPoller.cpp:160: ss process time was 0.000213

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000048
SelectPoller.cpp:160: ss process time was 0.000111

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000007

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000191
SelectPoller.cpp:160: ss process time was 0.000051

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.000171

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000112
SelectPoller.cpp:160: ss process time was 0.000091

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000016
SelectPoller.cpp:160: ss process time was 0.000052

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.001387
SelectPoller.cpp:160: ss process time was 0.000037
SelectPoller.cpp:160: ss process time was 0.000178
SelectPoller.cpp:160: ss process time was 0.000093

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000050

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000002
SelectPoller.cpp:160: ss process time was 0.000004

SelectPoller.cpp:160: ss process time was 0.000283

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000015
SelectPoller.cpp:160: ss process time was 0.000053
SelectPoller.cpp:160: ss process time was 0.000092

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001

SelectPoller.cpp:160: ss process time was 0.000014
SelectPoller.cpp:160: ss process time was 0.000048

SelectPoller.cpp:160: ss process time was 0.000003

SelectPoller.cpp:160: ss process time was 0.003848
SelectPoller.cpp:160: ss process time was 0.000019
SelectPoller.cpp:160: ss process time was 0.000451
SelectPoller.cpp:160: ss process time was 0.000361

SelectPoller.cpp:160: ss process time was 0.000002

SelectPoller.cpp:160: ss process time was 0.000006

SelectPoller.cpp:160: ss process time was 0.000001
SelectPoller.cpp:160: ss process time was 0.000013

SelectPoller.cpp:160: ss process time was 0.000321

OlaServer.cpp:343: Garbage collecting
SelectPoller.cpp:160: ss process time was 0.000003
SelectPoller.cpp:160: ss process time was 0.000002

^CSignalThread.cpp:99: Received signal: Interrupt

HTTPServer.cpp:485: Notifying HTTP server thread to stop
HTTPServer.cpp:487: Waiting for HTTP server thread to exit
HTTPServer.cpp:489: HTTP server thread exited

SelectPoller.cpp:160: ss process time was 0.000003

jmd@debian:~$

Peter Newman

unread,

Apr 26, 2017, 7:08:35 PM4/26/17

to RDM Testing

Yeah I'd suggest trying a build from source of 0.10.3. If you see the instructions here, most stuff is already in Debian so it's only OLA you need to actually compile:
https://www.openlighting.org/ola/linuxinstall/#Debian_Ubuntu

Are you seeing the Enttec unmute on the DMXter, and then nothing else?

Can we see logs (-l 4) for the Enttec too please, after your change.

Reply all

Reply to author

Forward

0 new messages