Chrome Version: R65-10210.0.0
OS: Chrome

audio_AudioBasicHeadphone and audio_AudioBasicHeadphone.suspend tests are failing with "Unhandled Exception: CrasUtilsError: Can not find unique node id from node type HDMI (RPC: audio.set_chrome_active_node_type)"

Test results  link: https://stainless.corp.google.com/search?exclude_cts=true&exclude_non_release=true&board=%5Epeach%5C_pi%24&suite=%5Echameleon%5C_audio%5C_perbuild%24&view=matrix&col=build&row=test&first_date=20171208&last_date=20171214

It started from R65-10210.0.0 build.


From debug logs:
============================
12/12 22:34:41.248 DEBUG|          ssh_host:0301| Running (ssh) 'true' from 'collect_client_job_results|wait_up|is_up|ssh_ping|run|run_very_slowly'
12/12 22:34:42.278 DEBUG|      abstract_ssh:0670| Host chromeos2-row10-rack10-host11 is now up
12/12 22:34:42.278 DEBUG|            runner:0089| result tools are already deployed to chromeos2-row10-rack10-host11.
12/12 22:34:42.279 DEBUG|            runner:0100| Getting directory summary for /tmp/sysinfo/autoserv-foXNpb/results/default
12/12 22:34:42.306 DEBUG|          ssh_host:0301| Running (ssh) '/usr/local/autotest/result_tools/utils.py -p /tmp/sysinfo/autoserv-foXNpb/results/default -m 20000' from '_do_run|execute_control|collect_client_job_results|run_on_client|run|run_very_slowly'
12/12 22:34:43.454 DEBUG|             utils:0280| [stdout] 2017-12-12 22:34:41,865 Running result_tools/utils on path: /tmp/sysinfo/autoserv-foXNpb/results/default
12/12 22:34:43.454 DEBUG|             utils:0280| [stdout] 2017-12-12 22:34:41,866 Throttle result size to : 19 MB
12/12 22:34:43.470 DEBUG|             utils:0280| [stdout] 2017-12-12 22:34:41,882 Directory summary of /tmp/sysinfo/autoserv-foXNpb/results/default is saved to file /tmp/sysinfo/autoserv-foXNpb/results/default/dir_summary_1513146881.json.
12/12 22:34:43.470 DEBUG|             utils:0280| [stdout] 2017-12-12 22:34:41,882 Skip throttling /tmp/sysinfo/autoserv-foXNpb/results/default: size=924311, throttle_probability=22.1570445445
12/12 22:34:43.482 DEBUG|      abstract_ssh:0413| get_file. source: /tmp/sysinfo/autoserv-foXNpb/results/default/, dest: /usr/local/autotest/results/162170657-chromeos-test, delete_dest: False,preserve_perm: True, preserve_symlinks:True
12/12 22:34:43.482 DEBUG|      abstract_ssh:0425| Using Rsync.
12/12 22:34:43.483 DEBUG|             utils:0212| Running 'rsync -l  --timeout=1800 --rsh='/usr/bin/ssh -a -x  -o Protocol=2 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=900 -o ServerAliveCountMax=3 -o ConnectionAttempts=4 -l root -p 22' -az --no-o --no-g  root@chromeos2-row10-rack10-host11:"/tmp/sysinfo/autoserv-foXNpb/results/default/" "/usr/local/autotest/results/162170657-chromeos-test"'
12/12 22:34:45.021 DEBUG|          base_job:0250| Value of client.sysinfo is unchanged, skipping import
12/12 22:34:45.021 DEBUG|          base_job:0253| Importing client.harness from state file /usr/local/autotest/results/162170657-chromeos-test/control.autoserv.state
12/12 22:34:45.021 DEBUG|          base_job:0253| Importing client.steps from state file /usr/local/autotest/results/162170657-chromeos-test/control.autoserv.state
12/12 22:34:45.022 DEBUG|          base_job:0253| Importing client._record_indent from state file /usr/local/autotest/results/162170657-chromeos-test/control.autoserv.state
12/12 22:34:45.022 DEBUG|          base_job:0250| Value of global_properties.max_result_size_KB is unchanged, skipping import
12/12 22:34:45.022 DEBUG|          base_job:0250| Value of global_properties.tag is unchanged, skipping import
12/12 22:34:45.022 DEBUG|          base_job:0250| Value of global_properties.test_retry is unchanged, skipping import
12/12 22:34:45.022 DEBUG|          base_job:0250| Value of global_properties.fast is unchanged, skipping import
12/12 22:34:45.024 DEBUG|          base_job:0399| Persistent state client.* deleted
12/12 22:34:45.025 DEBUG|          autotest:1151| Autotest job finishes.
12/12 22:34:45.025 DEBUG|      abstract_ssh:0413| get_file. source: /tmp/autoserv-zMY7U4/sysinfo.pickle, dest: /tmp/tmpZHBaIh, delete_dest: False,preserve_perm: True, preserve_symlinks:False
12/12 22:34:45.026 DEBUG|      abstract_ssh:0425| Using Rsync.
12/12 22:34:45.026 DEBUG|             utils:0212| Running 'rsync -L  --timeout=1800 --rsh='/usr/bin/ssh -a -x  -o Protocol=2 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=900 -o ServerAliveCountMax=3 -o ConnectionAttempts=4 -l root -p 22' -az --no-o --no-g  root@chromeos2-row10-rack10-host11:"/tmp/autoserv-zMY7U4/sysinfo.pickle" "/tmp/tmpZHBaIh"'
12/12 22:34:46.444 DEBUG|              test:0420| after_iteration_hooks completed
12/12 22:34:46.445 WARNI|              test:0637| The test failed with the following exception
Traceback (most recent call last):
  File "/usr/local/autotest/client/common_lib/test.py", line 631, in _exec
    _call_test_function(self.execute, *p_args, **p_dargs)
  File "/usr/local/autotest/client/common_lib/test.py", line 837, in _call_test_function
    raise error.UnhandledTestFail(e)
UnhandledTestFail: Unhandled Exception: CrasUtilsError: Can not find unique node id from node type HDMI (RPC: audio.set_chrome_active_node_type)
Traceback (most recent call last):
  File "/usr/local/autotest/client/common_lib/test.py", line 831, in _call_test_function
    return func(*args, **dargs)
  File "/usr/local/autotest/client/common_lib/test.py", line 495, in execute
    dargs)
  File "/usr/local/autotest/client/common_lib/test.py", line 362, in _call_run_once_with_retry
    postprocess_profiled_run, args, dargs)
  File "/usr/local/autotest/client/common_lib/test.py", line 400, in _call_run_once
    self.run_once(*args, **dargs)
  File "/usr/local/autotest/server/site_tests/audio_AudioBasicHDMI/audio_AudioBasicHDMI.py", line 124, in run_once
    audio_facade.set_chrome_active_node_type('HDMI', None)
  File "/usr/local/autotest/server/cros/multimedia/audio_facade_adapter.py", line 266, in set_chrome_active_node_type
    output_node_type, input_node_type)
  File "/usr/local/autotest/server/cros/multimedia/remote_facade_factory.py", line 60, in __call__
    return self.__call_method(self.__name, *args, **dargs)
  File "/usr/local/autotest/server/cros/multimedia/remote_facade_factory.py", line 171, in __call_proxy
    return call_rpc_with_log()
  File "/usr/local/autotest/server/cros/multimedia/remote_facade_factory.py", line 155, in call_rpc_with_log
    raise Exception('%s: %s' % (keyword, reason))
Exception: CrasUtilsError: Can not find unique node id from node type HDMI (RPC: audio.set_chrome_active_node_type)

12/12 22:34:46.446 DEBUG|              test:0642| Running cleanup for test.
12/12 22:34:46.577 DEBUG|             utils:0280| [client] 22:34:44 INFO | Dispatching method <bound method SystemFacadeNative.set_scaling_governor_mode of <autotest_lib.client.cros.multimedia.system_facade_native.SystemFacadeNative object at 0xb4f661d0>> with args (0, 'interactive')