New issue
Advanced search Search tips
Note: Color blocks (like █ or █) mean that a user may not be available. Tooltip shows the reason.

Issue 774697 link

Starred by 2 users
Status: Assigned
Owner:
cychiang@chromium.org
Cc:
tovep@chromium.org
dgreid@google.com
█ mnilsson@chromium.org
cychiang@chromium.org
chromeos-audio-bugs@google.com
Components:
EstimatedDays: ----
NextAction: ----
OS: Chrome
Pri: 3
Type: Bug



Sign in to add a comment

Chrome reports cras_client: error removing stream from server

Project Member Reported by mzhuo@chromium.org, Oct 13 2017 
CChrome Version: 
        Guado running meeting mode 
	ChromeOS: 9765.84.0	
        Chrome:   61.0.3163.123	
Note: did not see this error before 9765.84.0

Setup
----------
guado has Atrus, Mimo and huddly connected and is running as meeting device. 

What steps will reproduce the problem?
(1) Guado joins/leaves meeting in loop.
(2) when in meeting mute/unmute/change volume

What is the expected result?
No error

What happens instead?
=========================
Chrome reports cras_client: error removing stream from server:
2017-10-12T18:18:30.371489-07:00 ERR chrome[924]: cras_client: error removing stream from server
2017-10-12T18:18:30.374600-07:00 ERR chrome[924]: cras_client: error removing stream from server
2017-10-12T18:31:52.070506-07:00 ERR chrome[6829]: cras_client: error removing stream from server
2017-10-12T18:31:52.070694-07:00 ERR chrome[6829]: cras_client: error removing stream from server
2017-10-12T19:00:05.338246-07:00 ERR chrome[14005]: cras_client: error removing stream from server
2017-10-12T19:00:05.338320-07:00 ERR chrome[14005]: cras_client: error removing stream from server
2017-10-12T20:33:51.837873-07:00 ERR chrome[25870]: cras_client: error removing stream from server
2017-10-12T20:33:51.837884-07:00 ERR chrome[25870]: cras_client: error removing stream from server
2017-10-13T00:17:24.368603-07:00 ERR chrome[30861]: cras_client: error removing stream from server
2017-10-13T00:17:24.369541-07:00 ERR chrome[30861]: cras_client: error removing stream from server
2017-10-13T00:17:24.369547-07:00 ERR chrome[30861]: cras_client: error removing stream from server
2017-10-13T00:18:20.525711-07:00 ERR chrome[8379]: cras_client: error removing stream from server
2017-10-13T00:18:20.526536-07:00 ERR chrome[8379]: cras_client: error removing stream from server
2017-10-13T00:18:20.526622-07:00 ERR chrome[8379]: cras_client: error removing stream from server
2017-10-13T00:18:20.527384-07:00 ERR chrome[8379]: cras_client: error removing stream from server
2017-10-13T00:27:45.484224-07:00 ERR chrome[13637]: cras_client: error removing stream from server
2017-10-13T00:27:45.484240-07:00 ERR chrome[13637]: cras_client: error removing stream from server
2017-10-13T00:27:45.485449-07:00 ERR chrome[13637]: cras_client: error removing stream from server
2017-10-13T00:27:45.485454-07:00 ERR chrome[13637]: cras_client: error removing stream from server
2017-10-13T07:38:26.042681-07:00 ERR chrome[19638]: cras_client: error removing stream from server
2017-10-13T07:38:26.043063-07:00 ERR chrome[19638]: cras_client: error removing stream from server
2017-10-13T12:20:47.119562-07:00 ERR chrome[905]: cras_client: error removing stream from server
2017-10-13T12:20:47.120544-07:00 ERR chrome[905]: cras_client: error removing stream from server
debug-logs_20171013-140613.tgz
5.9 MB Download

Comment 1 by mzhuo@chromium.org, Oct 13 2017

Labels: OS-Chrome

Comment 2 by mlamouri@chromium.org, Oct 17 2017

Components: -Blink>Media>Audio Internals>WebRTC

Comment 3 by mzhuo@chromium.org, Dec 15 2017

Labels: M-63
Got this error with R63-10032.71.1 on BS's guado.

ocalhost ~ # grep "cras_client: error removing stream from server"  /var/log/messages.2 -B 100 | grep -E "ERR kernel|ERR cras|error removing" | more
2017-12-12T18:59:31.997269-08:00 ERR cras_server[3428]: pcm_avail returned frames larger than buf_size: Hangouts Meet speakermic: USB Audio:0,0: 262208 > 262
144 for 146 times
2017-12-12T19:01:01.529088-08:00 ERR crash_reporter[18884]: Could not write file /var/spool/crash/chrome.20171212.190101.4436.i915_error_state.log.xz Written
: -1 Len: 84
2017-12-12T19:01:01.529493-08:00 ERR crash_reporter[18884]: Unable to write /var/spool/crash/chrome.20171212.190101.4436.meta
2017-12-12T19:01:03.316270-08:00 ERR crash_reporter[18923]: Could not write file /var/spool/crash/chrome.20171212.190101.4436.i915_error_state.log.xz Written
: -1 Len: 84
2017-12-12T19:01:03.316476-08:00 ERR crash_reporter[18923]: Unable to write /var/spool/crash/chrome.20171212.190101.4436.meta
2017-12-12T19:01:25.437011-08:00 ERR cras_server[3428]: pcm_avail returned frames larger than buf_size: Hangouts Meet speakermic: USB Audio:0,0: 262416 > 262
144 for 151 times
2017-12-12T19:01:55.484262-08:00 ERR cras_server[3428]: pcm_avail returned frames larger than buf_size: Hangouts Meet speakermic: USB Audio:0,0: 262400 > 262
144 for 2106 times
2017-12-12T19:02:26.476360-08:00 ERR cras_server[3428]: pcm_avail returned frames larger than buf_size: Hangouts Meet speakermic: USB Audio:0,0: 262400 > 262
144 for 4087 times
2017-12-12T19:02:57.484899-08:00 ERR cras_server[3428]: pcm_avail returned frames larger than buf_size: Hangouts Meet speakermic: USB Audio:0,0: 262400 > 262
144 for 6037 times
2017-12-12T19:04:07.868813-08:00 ERR cras_server[3428]: pcm_avail returned frames larger than buf_size: Hangouts Meet speakermic: USB Audio:0,0: 262400 > 262
144 for 6046 times
2017-12-12T19:04:34.087782-08:00 ERR chrome[3945]: cras_client: error removing stream from server
2017-12-12T19:04:34.204652-08:00 ERR chrome[3945]: cras_client: error removing stream from server
2017-12-12T19:05:12.580179-08:00 ERR chrome[19202]: cras_client: error removing stream from server
2017-12-12T19:05:12.580947-08:00 ERR chrome[19202]: cras_client: error removing stream from server
2017-12-12T19:05:12.583833-08:00 ERR chrome[19202]: cras_client: error removing stream from server
2017-12-12T23:35:30.266564-08:00 ERR chrome[936]: cras_client: error removing stream from server
2017-12-12T23:35:30.266661-08:00 ERR chrome[936]: cras_client: error removing stream from server
2017-12-12T23:45:51.946344-08:00 ERR cras_server[5145]: pcm_avail returned frames larger than buf_size: Hangouts Meet speakermic: USB Audio:0,0: 262160 > 262
144 for 1 times
2017-12-12T23:46:58.620126-08:00 ERR chrome[7805]: cras_client: error removing stream from server
2017-12-12T23:46:58.620140-08:00 ERR chrome[7805]: cras_client: error removing stream from server
2017-12-13T00:04:10.969431-08:00 ERR chrome[970]: cras_client: error removing stream from server
2017-12-13T00:04:10.969471-08:00 ERR chrome[970]: cras_client: error removing stream from server
2017-12-13T00:04:29.668566-08:00 ERR cras_server[3962]: Fail to create conversion matrix due to invalid channel layout
2017-12-13T00:06:25.459991-08:00 ERR cras_server[3962]: pcm_avail returned frames larger than buf_size: Hangouts Meet speakermic: USB Audio:0,0: 262240 > 262
144 for 1 times
2017-12-13T00:11:40.554616-08:00 ERR cras_s

Comment 4 by mzhuo@google.com, Dec 15 2017 

Attaching debug log for #3.
100.107.146.4.debug-logs_20171213-084829.tgz
3.8 MB Download

Comment 5 by mzhuo@google.com, Dec 15 2017 

Another instance with R63-10032.71.1.
100.107.146.16.debug-logs_20171213-084836.tgz
24.7 MB Download

Comment 6 by mzhuo@chromium.org, Dec 16 2017

Cc: mnilsson@chromium.org tovep@chromium.org

Comment 7 by anatolid@chromium.org, Jan 18 2018 

Ping for triaging.

Comment 8 by deadbeef@chromium.org, Jan 18 2018

Components: -Internals>WebRTC OS>Kernel>Audio
Reassigning to OS->Kernel>Audio, since that seems to be where CRAS-related issues go.

Comment 9 by dgreid@chromium.org, Jan 18 2018

Owner: cychiang@chromium.org
"cras_client: error removing stream from server" isn't something to lose sleep over.

The insane return values of pcm_avail in the the log are however. What on earth is that speaker doing?

Comment 10 by benhenry@chromium.org, Aug 1

Status: Assigned (was: Untriaged)
►

Sign in to add a comment