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

Issue 741906 link

Starred by 2 users

Issue metadata

Status: Duplicate
Merged: issue webrtc:7551
Owner:
Last visit > 30 days ago
Closed: Jul 2017
Cc:
Components:
EstimatedDays: ----
NextAction: ----
OS: Chrome
Pri: 2
Type: Bug
R60
R61



Sign in to add a comment

Too many log for similar warning in chrome log complaining "Frame depends on earlier frame", hence dropping frame.

Project Member Reported by mzhuo@chromium.org, Jul 12 2017

Issue description

Platform: Chromebox running meeting mode

localhost chrome # cat /etc/os-release                                                                                                                                                                     
BUILD_ID=9737.0.0
NAME=Chrome OS
ID_LIKE=chromiumos
GOOGLE_CRASH_ID=ChromeOS
VERSION_ID=61
BUG_REPORT_URL=https://crbug.com/new
VERSION=61
HOME_URL=https://www.chromium.org/chromium-os
ID=chromeos
localhost chrome # cat /etc/lsb-release [1:22:0712/151152.026061:WARNING:frame_buffer2.cc(455)] Frame with (picture_id:spatial_id) (2644:0 depends on a non-decoded frame more previous than the last decoded frame, dropping frame.

CHROMEOS_RELEASE_APPID={8AA6D9AC-6EBC-4288-A615-171F56F66B4E}
CHROMEOS_BOARD_APPID={8AA6D9AC-6EBC-4288-A615-171F56F66B4E}
CHROMEOS_CANARY_APPID={90F229CE-83E2-4FAF-8479-E368A34938B1}
DEVICETYPE=CHROMEBOX
CHROMEOS_RELEASE_BUILDER_PATH=guado-release/R61-9737.0.0
GOOGLE_RELEASE=9737.0.0
CHROMEOS_DEVSERVER=
CHROMEOS_RELEASE_BOARD=guado
CHROMEOS_RELEASE_BUILD_NUMBER=9737
CHROMEOS_RELEASE_BRANCH_NUMBER=0
CHROMEOS_RELEASE_CHROME_MILESTONE=61
CHROMEOS_RELEASE_PATCH_NUMBER=0
CHROMEOS_RELEASE_TRACK=testimage-channel
CHROMEOS_RELEASE_DESCRIPTION=9737.0.0 (Official Build) dev-channel guado test
CHROMEOS_RELEASE_BUILD_TYPE=Official Build
CHROMEOS_RELEASE_NAME=Chrome OS
CHROMEOS_RELEASE_VERSION=9737.0.0
CHROMEOS_AUSERVER=https://tools.google.com/service/update2
localhost chrome #                                                                                                                                                                                         

What steps will reproduce the problem?
(1) Start meeting from MAC
    version on Mac: 
    
Google Chrome	59.0.3071.115 (Official Build) (64-bit)
Revision	3cf8514bb1239453fd15ff1f7efee389ac9df8ba-refs/branch-heads/3071@{#820}
OS	Mac OS X

(2) join meeting from 2 chromebox 

What is the expected result?
===============================
First don't expect to see this warning. Looks like something not right, hence dropping frame. 
Don't expect to see many logs. If indeed something wrong compress the log.

What happens instead?
on both Chromebox running meeting mode see continuous logs in file /var/log/chrome/chrome

Please use labels and text to provide additional information.
1:22:0712/151407.094611:WARNING:frame_buffer2.cc(455)] Frame with (picture_id:spatial_id) (6695:0 depends on a non-decoded frame more previous than the last decoded frame, dropping frame.
[1:22:0712/151413.169415:WARNING:frame_buffer2.cc(455)] Frame with (picture_id:spatial_id) (44513:0 depends on a non-decoded frame more previous than the last decoded frame, dropping frame.

on 1st Chromebox:
localhost chrome # cat chrome | grep "depends on a non-decoded frame more" | wc -l                                                                                                                         
747
localhost chrome # cat chrome |  wc -l                                                                                                                                                                     
1120
localhost chrome # ls -altr                                                                                                                                                                                
total 26636
-rw-r--r--  1 chronos chronos    87606 Jul 10 23:17 chrome_20170710-231200
-rw-r--r--  1 chronos chronos    18326 Jul 10 23:18 chrome_20170710-231752
-rw-r--r--  1 chronos chronos     6538 Jul 10 23:18 chrome_20170710-231816
-rw-r--r--  1 chronos chronos    12840 Jul 10 23:18 chrome_20170710-231819
-rw-r--r--  1 chronos chronos    10522 Jul 10 23:19 chrome_20170710-231848
-rw-r--r--  1 chronos chronos        0 Jul 10 23:19 chrome_20170710-231902
-rw-r--r--  1 chronos chronos     7196 Jul 10 23:19 chrome_20170710-231903
-rw-r--r--  1 chronos chronos        0 Jul 10 23:19 chrome_20170710-231908
-rw-r--r--  1 chronos chronos 26859843 Jul 12 10:11 chrome_20170710-231909
-rw-r--r--  1 chronos chronos        0 Jul 12 12:01 chrome_20170712-120102
-rw-r--r--  1 chronos chronos    21955 Jul 12 12:16 chrome_20170712-120103
-rw-r--r--  1 chronos chronos    11180 Jul 12 12:18 chrome_20170712-121753
drwx------  2 chronos chronos     4096 Jul 12 12:18 Crash Reports
-rw-r--r--  1 chronos chronos        0 Jul 12 12:18 chrome_20170712-121854
drwxrwxr-t 10 root    syslog      4096 Jul 12 12:18 ..
lrwxrwxrwx  1 chronos chronos       38 Jul 12 12:18 chrome -> /var/log/chrome/chrome_20170712-121855
drwxr-xr-x  3 chronos chronos     4096 Jul 12 12:18 .
-rw-r--r--  1 chronos chronos   193231 Jul 12 15:18 chrome_20170712-121855
localhost chrome #                          

on 2nd:
localhost chrome #  cat chrome | grep "depends on a non-decoded frame more" | wc -l                                                                                                                        
2178
localhost chrome # cat chrome |  wc -l                                                                                                                                                                     
2456
localhost chrome # ls -altr                                                                                                                                                                                
total 968
-rw-r--r--  1 chronos chronos  20564 Jul 11 15:44 chrome_20170711-154405
-rw-r--r--  1 chronos chronos   6551 Jul 11 15:44 chrome_20170711-154456
-rw-r--r--  1 chronos chronos   9194 Jul 11 15:45 chrome_20170711-154458
-rw-r--r--  1 chronos chronos   7967 Jul 11 15:46 chrome_20170711-154546
-rw-r--r--  1 chronos chronos  10873 Jul 11 15:46 chrome_20170711-154621
-rw-r--r--  1 chronos chronos   6062 Jul 11 15:46 chrome_20170711-154647
-rw-r--r--  1 chronos chronos   8932 Jul 11 15:47 chrome_20170711-154649
-rw-r--r--  1 chronos chronos   7967 Jul 11 15:52 chrome_20170711-154736
-rw-r--r--  1 chronos chronos  11028 Jul 11 15:52 chrome_20170711-155227
-rw-r--r--  1 chronos chronos   6064 Jul 11 15:52 chrome_20170711-155251
-rw-r--r--  1 chronos chronos   8932 Jul 11 15:53 chrome_20170711-155253
-rw-r--r--  1 chronos chronos  11499 Jul 11 15:57 chrome_20170711-155343
-rw-r--r--  1 chronos chronos  90111 Jul 12 12:17 chrome_20170711-155741
-rw-r--r--  1 chronos chronos  12735 Jul 12 12:27 chrome_20170712-121742
-rw-r--r--  1 chronos chronos  11928 Jul 12 12:28 chrome_20170712-122745
-rw-r--r--  1 chronos chronos   7155 Jul 12 12:28 chrome_20170712-122809
-rw-r--r--  1 chronos chronos  11211 Jul 12 12:29 chrome_20170712-122811
-rw-r--r--  1 chronos chronos   9230 Jul 12 12:32 chrome_20170712-122913
-rw-r--r--  1 chronos chronos  11928 Jul 12 12:32 chrome_20170712-123208
-rw-r--r--  1 chronos chronos      0 Jul 12 12:32 chrome_20170712-123231
-rw-r--r--  1 chronos chronos   7157 Jul 12 12:32 chrome_20170712-123232
-rw-r--r--  1 chronos chronos  18537 Jul 12 12:33 chrome_20170712-123233
-rw-r--r--  1 chronos chronos  13256 Jul 12 12:33 chrome_20170712-123315
-rw-r--r--  1 chronos chronos      0 Jul 12 12:33 chrome_20170712-123325
-rw-r--r--  1 chronos chronos  14134 Jul 12 12:33 chrome_20170712-123326
-rw-r--r--  1 chronos chronos      0 Jul 12 12:33 chrome_20170712-123331
-rw-r--r--  1 chronos chronos  30479 Jul 12 12:35 chrome_20170712-123332
-rw-r--r--  1 chronos chronos  10101 Jul 12 12:37 chrome_20170712-123533
drwx------  2 chronos chronos   4096 Jul 12 12:37 Crash Reports
-rw-r--r--  1 chronos chronos   4722 Jul 12 12:37 chrome_20170712-123734
-rw-r--r--  1 chronos chronos      0 Jul 12 12:38 chrome_20170712-123805
-rw-r--r--  1 chronos chronos  17555 Jul 12 12:39 chrome_20170712-123806
-rw-r--r--  1 chronos chronos   9949 Jul 12 12:39 chrome_20170712-123910
-rw-r--r--  1 chronos chronos  18452 Jul 12 12:40 chrome_20170712-123934
-rw-r--r--  1 chronos chronos      0 Jul 12 12:40 chrome_20170712-124043
-rw-r--r--  1 chronos chronos  31449 Jul 12 12:42 chrome_20170712-124044
-rw-r--r--  1 chronos chronos  10367 Jul 12 12:43 chrome_20170712-124252
drwxrwxr-t 11 root    syslog    4096 Jul 12 12:43 ..
lrwxrwxrwx  1 chronos chronos     38 Jul 12 12:43 chrome -> /var/log/chrome/chrome_20170712-124350
drwxr-xr-x  3 chronos chronos   4096 Jul 12 12:43 .
-rw-r--r--  1 chronos chronos 451757 Jul 12 15:18 chrome_20170712-124350
localhost chrome #                                                                                                                                                                                         


Code location://depot/google3/third_party/webrtc/files/stable/webrtc/modules/video_coding/frame_buffer2.cc

// Does |frame| depend on a frame earlier than the last decoded frame?
    if (last_decoded_frame_it_ != frames_.end() &&
        ref_key <= last_decoded_frame_it_->first) {
      if (ref_info == frames_.end()) {
        LOG(LS_WARNING) << "Frame with (picture_id:spatial_id) ("
                        << key.picture_id << ":"
                        << static_cast<int>(key.spatial_layer)
                        << " depends on a non-decoded frame more previous than "
                        << "the last decoded frame, dropping frame.";
        return false;
      }
 
debug-logs_20170712-151735.tgz
2.9 MB Download
debug-logs_20170712-151739.tgz
2.5 MB Download

Comment 1 by mzhuo@chromium.org, Jul 12 2017

Cc: skvlad@google.com deadbeef@google.com philipel@google.com glaznev@google.com kwiberg@google.com minyue@google.com

Comment 2 by mzhuo@chromium.org, Jul 12 2017

Cc: -skvlad@google.com -kwiberg@google.com katierh@chromium.org choonc@google.com
Summary: Too many log for similar warning in chrome log complaining "Frame depends on earlier frame", hence dropping frame. (was: Too many log for same warning in chrome log )

Comment 3 by mzhuo@chromium.org, Jul 12 2017

Labels: -Pri-3 Pri-1

Comment 4 by mzhuo@chromium.org, Jul 12 2017

Labels: OS-Chrome

Comment 5 by mzhuo@chromium.org, Jul 12 2017

attach web-rtc log from MAC which is in the same meeting as other 2 Chromebox.
1499893036.116155.gz
145 KB Download

Comment 6 by mzhuo@chromium.org, Jul 13 2017

Labels: -Pri-1 Pri-2
Owner: huib@chromium.org
Huib - can you find an owner for this?

Comment 8 by huib@chromium.org, Jul 13 2017

Owner: terelius@chromium.org
Björn, can you comment on this?
Cc: terelius@chromium.org
Owner: philipel@chromium.org
Status: Assigned (was: Untriaged)
Philip is a better owner for this.
Mergedinto: webrtc:7551
Status: Duplicate (was: Assigned)
Have a bug for this, haven't gotten around to fix it yet, will do it soon.

Comment 11 by mzhuo@chromium.org, Jul 14 2017

Components: Internals>WebRTC

Comment 12 by mzhuo@chromium.org, Jul 14 2017

Labels: R61 R60

Sign in to add a comment