Noisy driver logging when using a light with driver

[bosh]

When using a driver for a flasher or other light, there is an info log on _enable_now at

mpf/mpf/devices/driver.py

Line 263 in 9ce8bc8

self.info_log("Enabling Driver with power %s (pulse_ms %sms and pulse_power %s)", hold_power, pulse_ms,

that can be excessively noisy. I can live with it, but maybe it's reasonable to add a config override (or should I just deal with it until I turn off info logging?)

Setup example:

coils:
  c_start_driver:
    allow_enable: true

lights:
  l_start:
    number: c_start_driver
    platform: drivers
    type: r     # single color flasher type bulb

# + a light show on the light

Output ends up being like

12:43:31.212 : INFO [coil.c_start_driver] Enabling Driver with power 0.07500000058207662 (pulse_ms 10ms and pulse_power 1.0)
12:43:31.242 : INFO [coil.c_start_driver] Enabling Driver with power 0.2 (pulse_ms 10ms and pulse_power 1.0)
12:43:31.429 : INFO [coil.c_start_driver] Enabling Driver with power 0.19333333379899464 (pulse_ms 10ms and pulse_power 1.0)
12:43:31.463 : INFO [coil.c_start_driver] Enabling Driver with power 0.4666666666666667 (pulse_ms 10ms and pulse_power 1.0)
12:43:31.649 : INFO [coil.c_start_driver] Enabling Driver with power 0.5316666667830819 (pulse_ms 10ms and pulse_power 1.0)
12:43:31.681 : INFO [coil.c_start_driver] Enabling Driver with power 0.6666666666666666 (pulse_ms 10ms and pulse_power 1.0)
12:43:31.871 : INFO [coil.c_start_driver] Enabling Driver with power 0.7666666674427688 (pulse_ms 10ms and pulse_power 1.0)
12:43:31.901 : INFO [coil.c_start_driver] Enabling Driver with power 1.0 (pulse_ms 10ms and pulse_power 1.0)
12:43:32.150 : INFO [coil.c_start_driver] Enabling Driver with power 1.0 (pulse_ms 10ms and pulse_power 1.0)
12:43:32.184 : INFO [coil.c_start_driver] Enabling Driver with power 0.40000000116415324 (pulse_ms 10ms and pulse_power 1.0)
12:43:32.214 : INFO [coil.c_start_driver] Disabling Driver

for just a 1 second piece of light show on the light. Actually looking at the show, I guess that's because I hit 5 different brightness levels in that loop as it fades on/off, but no other light is spamming like this.

Using console_log: none on the driver definition did not reduce the logging either.

I'd propose either linking this to console_log or adding a new property to coils/drivers. Thoughts?

[avanwinkle]

Interesting, I did see the logging disappear when I added console_log: none and/or file_log: none to the driver. Like this:

  c_start_button_standard:
    number: pfio-01
    allow_enable: true
    console_log: none
    file_log: none

Without those lines I see the logs, but with them I don't. Can you share your full driver config?

[bosh]

Huh, with console_log: none AND file_log: none the messages go away. If only one of the two is set to none (or neither), then I see the message in the console logging.

This was from my full game definition, defining the coil here https://github.com/bosh/trogdor-pinball/blob/c6572308b40384658dede84a8ad994c2ddb384c5/config/coils.yaml#L122 but I don't think I have anything else funny going on. We can probably close this issue and I'll just add both log nones to my config, but if I have time I might dig into the logging system to understand if there is a teeing issue.