Testcase: test_reads_music_library(with touch)

Build #:214:20140301:20140228.1
Arch:mako (Nexus 4)
Release:trusty
Variant:touch
Artifacts
Console Log

Failure explanation

This test failure has not yet been categorized.
Log in to edit.

Test case data

testcase
test_reads_music_library(with touch)
testsuite
music_app.tests.test_music.TestMainWindow
returncode
1
command
autopilot
stderr
_StringException: /var/log/syslog: {{{
Mar  1 06:57:03 ubuntu-phablet kernel: [  147.217335] SLIM_CL: skip reconfig sequence
Mar  1 06:57:03 ubuntu-phablet kernel: [  147.231100] amp_enable: amp enable bypass(2)
Mar  1 06:57:03 ubuntu-phablet kernel: [  147.231161] amp_enable: AMP_EN is set to 0
Mar  1 06:57:04 ubuntu-phablet kernel: [  147.775766] wlan: [1245:E :SME] csrMoveTempScanResultsToMainList: 2908: 11d AP Bssid 00:21:d8:49:c8:e3 chan=
1, rssi = -66, countryCode US
Mar  1 06:57:04 ubuntu-phablet kernel: [  147.776865] wlan: [1245:E :SME] csrMoveTempScanResultsToMainList: 2908: 11d AP Bssid 74:91:1a:28:c5:dd chan=
161, rssi = -59, countryCode US
Mar  1 06:57:04 ubuntu-phablet kernel: [  147.777536] wlan: [1245:E :SME] csrMoveTempScanResultsToMainList: 2928: Information about current country
Bssid 74:91:1a:28:c5:dd chan= 161, rssi = -59, countryCode US
Mar  1 06:57:04 ubuntu-phablet kernel: [  147.779764] wlan: [1245:E :SME] csrMoveTempScanResultsToMainList: 2908: 11d AP Bssid 74:91:1a:a8:c5:dc chan=
161, rssi = -58, countryCode US
Mar  1 06:57:08 ubuntu-phablet kernel: [  152.120524] healthd: battery l=100 v=4313 t=23.6 h=2 st=5 c=1 chg=u
Mar  1 06:57:18 ubuntu-phablet kernel: [  162.119578] healthd: battery l=100 v=4313 t=23.6 h=2 st=5 c=1 chg=u
Mar  1 06:57:18 ubuntu-phablet kernel: [  162.122966] adjust_soc: ibat_ua = 1600, vbat_uv = 4314267, soc = 100, batt_temp=236
Mar  1 06:57:28 ubuntu-phablet kernel: [  172.114481] healthd: battery l=100 v=4313 t=23.6 h=2 st=5 c=1 chg=u
Mar  1 06:57:38 ubuntu-phablet kernel: [  182.167984] adjust_soc: ibat_ua = 1000, vbat_uv = 4313973, soc = 100, batt_temp=236
Mar  1 06:57:38 ubuntu-phablet kernel: [  182.172073] healthd: battery l=100 v=4314 t=23.6 h=2 st=5 c=1 chg=u
Mar  1 06:57:38 ubuntu-phablet kernel: [  182.301175] healthd: battery l=100 v=4314 t=23.6 h=2 st=5 c=1 chg=u
}}}

Application Log: {{{
** (process:3292): WARNING **: Unable to resolve '' to a filename: The URI '' is not an absolute URI using the "file" scheme
/usr/lib/arm-linux-gnueabihf/qt5/bin/qmlscene: unrecognized option '--file='
/usr/lib/arm-linux-gnueabihf/qt5/bin/qmlscene: invalid option -- 'I'
Testability driver loaded. Wire protocol version is "1.4".
Debug: Queue: Now has: 0 tracks
Debug: onCountChanged: 0
RECENT does not exist
Registry is ready
Available ? true
griloModel.count 0
[30,125,124,123,122,121,29,120,40,119,118,117,28,25,33,116,31,115,44,114,22,7,47,113,21,46,49,36,112,111,41,20,110,109,108,19,107,18,17,16,106,105,45,104,39,103,102,23,14,101,100,99,98,97,96,95,94,93,92,91,90,13,12,89,88,37,87,43,11,38,86,32,85,84,83,9,82,48,8,34,26,81,80,79,78,77,76,75,5,74,73,72,71,70,69,68,67,66,65,64,35,63,62,61,3,60,4,2,59,58,57,56,55,54,1]
[]
Refreshing
Debug: Version 1.2
Debug: Arguments on startup: Debug: false
Debug: Arguments on startup: Debug: false and file: 
INITIALIZED in tracks
reset settings
Playlist DB is version 
DB: No change in playlist.
callbacks 0xb3dafead 0xb3dafe59
creating surface at (0, 58) with size (768, 1222) with title 'qmlscene: music'QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 

(qmlscene:3292): mediascanner-WARNING **: Found cover art: 

(qmlscene:3292): GLib-CRITICAL **: g_date_time_get_year: assertion 'datetime != NULL' failed

(qmlscene:3292): GLib-CRITICAL **: g_date_time_get_year: assertion 'datetime != NULL' failed

(qmlscene:3292): GLib-CRITICAL **: g_date_time_get_year: assertion 'datetime != NULL' failed
Writing DB
3
Grilo duplicates: 0
called LibraryListModel::filterRecent()
called LibraryListModel::filterGenres()
{"artist":"Benjamin Kerensa","album":"Unknown Album","title":"Foss Yeaaaah! (Radio
Edit)","file":"/home/phablet/Music/1.ogg","cover":"","length":"53","year":"Unknown Year","genre":"Unknown Genre","total":3}
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
Detectable autorepeat not supported. 
called LibraryListModel::filterArtists()
{"artist":"Benjamin Kerensa","album":"Unknown Album","title":"Foss Yeaaaah! (Radio
Edit)","file":"/home/phablet/Music/1.ogg","cover":"","length":"53","year":"Unknown Year","genre":"Unknown Genre"}
{"artist":"Josh Woodward","album":"Unknown Album","title":"Swansong","file":"/home/phablet/Music/2.ogg","cover":"","length":"62","year":"Unknown
Year","genre":"Unknown Genre"}
{"artist":"TestMP3Artist","album":"TestMP3Album","title":"TestMP3Title","file":"/home/phablet/Music/3.mp3","cover":"","length":"6","year":"Unknown
Year","genre":"Unknown Genre"}
called LibraryListModel::filterAlbums()
{"artist":"TestMP3Artist","album":"TestMP3Album","title":"TestMP3Title","file":"/home/phablet/Music/3.mp3","cover":"","length":"6","year":"Unknown
Year","genre":"Unknown Genre"}
{"artist":"Benjamin Kerensa","album":"Unknown Album","title":"Foss Yeaaaah! (Radio
Edit)","file":"/home/phablet/Music/1.ogg","cover":"","length":"53","year":"Unknown Year","genre":"Unknown Genre"}
called LibraryListModel::populate()
{"artist":"Benjamin Kerensa","album":"Unknown Album","title":"Foss Yeaaaah! (Radio
Edit)","file":"/home/phablet/Music/1.ogg","cover":"","length":"53","year":"Unknown Year","genre":"Unknown Genre"}
{"artist":"Josh Woodward","album":"Unknown Album","title":"Swansong","file":"/home/phablet/Music/2.ogg","cover":"","length":"62","year":"Unknown
Year","genre":"Unknown Genre"}
{"artist":"TestMP3Artist","album":"TestMP3Album","title":"TestMP3Title","file":"/home/phablet/Music/3.mp3","cover":"","length":"6","year":"Unknown
Year","genre":"Unknown Genre"}
 file:///home/phablet/Music/1.ogg
Debug: Queue: Now has: 1 tracks
Debug: MusicQueue update currentIndex: file:///home/phablet/Music/1.ogg
file:///usr/share/click/preinstalled/com.ubuntu.music/1.1.359/common/BlurredBackground.qml:28:5: QML QQuickImage: Cannot open:
file:///usr/share/click/preinstalled/com.ubuntu.music/1.1.359/common/images/cover_default_icon.png
file:///usr/share/click/preinstalled/com.ubuntu.music/1.1.359/common/BlurredBackground.qml:28:5: QML QQuickImage: Cannot open:
file:///usr/share/click/preinstalled/com.ubuntu.music/1.1.359/common/images/cover_default_icon.png
Click of fileName: /home/phablet/Music/1.ogg
Debug: Queue: Now has: 3 tracks
Debug: MusicQueue update currentIndex: file:///home/phablet/Music/1.ogg
mainView.isPlaying=true, QtPowerd.keepAlive=true
Source: file:///home/phablet/Music/1.ogg
Index: 0
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures

** (process:3571): WARNING **: Unable to resolve '' to a filename: The URI '' is not an absolute URI using the "file" scheme
/usr/lib/arm-linux-gnueabihf/qt5/bin/qmlscene: unrecognized option '--file='
/usr/lib/arm-linux-gnueabihf/qt5/bin/qmlscene: invalid option -- 'I'
Testability driver loaded. Wire protocol version is "1.4".
Debug: Queue: Now has: 0 tracks
Debug: onCountChanged: 0
RECENT does not exist
Registry is ready
Available ? true
griloModel.count 0
[30,125,124,123,122,121,29,120,40,119,118,117,28,25,33,116,31,115,44,114,22,7,47,113,21,46,49,36,112,111,41,20,110,109,108,19,107,18,17,16,106,105,45,104,39,103,102,23,14,101,100,99,98,97,96,95,94,93,92,91,90,13,12,89,88,37,87,43,11,38,86,32,85,84,83,9,82,48,8,34,26,81,80,79,78,77,76,75,5,74,73,72,71,70,69,68,67,66,65,64,35,63,62,61,3,60,4,2,59,58,57,56,55,54,1]
[]
Refreshing
Debug: Version 1.2
Debug: Arguments on startup: Debug: false
Debug: Arguments on startup: Debug: false and file: 
INITIALIZED in tracks
reset settings
Playlist DB is version 
DB: No change in playlist.
callbacks 0xb3de8ead 0xb3de8e59
creating surface at (0, 58) with size (768, 1222) with title 'qmlscene: music'QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 

(qmlscene:3571): mediascanner-WARNING **: Found cover art: 

(qmlscene:3571): GLib-CRITICAL **: g_date_time_get_year: assertion 'datetime != NULL' failed

(qmlscene:3571): GLib-CRITICAL **: g_date_time_get_year: assertion 'datetime != NULL' failed

(qmlscene:3571): GLib-CRITICAL **: g_date_time_get_year: assertion 'datetime != NULL' failed
Writing DB
3
Grilo duplicates: 0
called LibraryListModel::filterRecent()
called LibraryListModel::filterGenres()
{"artist":"Benjamin Kerensa","album":"Unknown Album","title":"Foss Yeaaaah! (Radio
Edit)","file":"/home/phablet/Music/1.ogg","cover":"","length":"53","year":"Unknown Year","genre":"Unknown Genre","total":3}
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
Detectable autorepeat not supported. 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
called LibraryListModel::filterGenreTracks()
{"artist":"Benjamin Kerensa","album":"Unknown Album","title":"Foss Yeaaaah! (Radio
Edit)","file":"/home/phablet/Music/1.ogg","cover":"","length":"53","year":"Unknown Year","genre":"Unknown Genre"}
{"artist":"Josh Woodward","album":"Unknown Album","title":"Swansong","file":"/home/phablet/Music/2.ogg","cover":"","length":"62","year":"Unknown
Year","genre":"Unknown Genre"}
{"artist":"TestMP3Artist","album":"TestMP3Album","title":"TestMP3Title","file":"/home/phablet/Music/3.mp3","cover":"","length":"6","year":"Unknown
Year","genre":"Unknown Genre"}
 file:///home/phablet/Music/1.ogg
Debug: Queue: Now has: 1 tracks
Debug: MusicQueue update currentIndex: file:///home/phablet/Music/1.ogg
file:///usr/share/click/preinstalled/com.ubuntu.music/1.1.359/common/BlurredBackground.qml:28:5: QML QQuickImage: Cannot open:
file:///usr/share/click/preinstalled/com.ubuntu.music/1.1.359/common/images/cover_default_icon.png
file:///usr/share/click/preinstalled/com.ubuntu.music/1.1.359/common/BlurredBackground.qml:28:5: QML QQuickImage: Cannot open:
file:///usr/share/click/preinstalled/com.ubuntu.music/1.1.359/common/images/cover_default_icon.png
Click of fileName: /home/phablet/Music/1.ogg
Debug: Queue: Now has: 3 tracks
Debug: MusicQueue update currentIndex: file:///home/phablet/Music/1.ogg
mainView.isPlaying=true, QtPowerd.keepAlive=true
Source: file:///home/phablet/Music/1.ogg
Index: 0
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
ShaderEffect: source or provider missing when binding textures
mainView.isPlaying=false, QtPowerd.keepAlive=false
Shuffle: true
0
2
mainView.isPlaying=false, QtPowerd.keepAlive=false
Debug: MusicQueue update currentIndex: file:///home/phablet/Music/3.mp3
MediaPlayer statusChanged, currentIndex: 2
Playing: file:///home/phablet/Music/3.mp3
mainView.isPlaying=true, QtPowerd.keepAlive=true
Debug: no scrobbling
mainView.isPlaying=false, QtPowerd.keepAlive=false
Shuffle: false
currentIndex: 2
trackQueue.count: 3
mainView.isPlaying=false, QtPowerd.keepAlive=false
Debug: MusicQueue update currentIndex: file:///home/phablet/Music/2.ogg
MediaPlayer statusChanged, currentIndex: 1
Playing: file:///home/phablet/Music/2.ogg
mainView.isPlaying=true, QtPowerd.keepAlive=true
Debug: no scrobbling

** (process:4002): WARNING **: Unable to resolve '' to a filename: The URI '' is not an absolute URI using the "file" scheme
/usr/lib/arm-linux-gnueabihf/qt5/bin/qmlscene: unrecognized option '--file='
/usr/lib/arm-linux-gnueabihf/qt5/bin/qmlscene: invalid option -- 'I'
Testability driver loaded. Wire protocol version is "1.4".
Debug: Queue: Now has: 0 tracks
Debug: onCountChanged: 0
RECENT does not exist
Registry is ready
Available ? true
griloModel.count 0
[30,125,124,123,122,121,29,120,40,119,118,117,28,25,33,116,31,115,44,114,22,7,47,113,21,46,49,36,112,111,41,20,110,109,108,19,107,18,17,16,106,105,45,104,39,103,102,23,14,101,100,99,98,97,96,95,94,93,92,91,90,13,12,89,88,37,87,43,11,38,86,32,85,84,83,9,82,48,8,34,26,81,80,79,78,77,76,75,5,74,73,72,71,70,69,68,67,66,65,64,35,63,62,61,3,60,4,2,59,58,57,56,55,54,1]
[]
Refreshing
Debug: Version 1.2
Debug: Arguments on startup: Debug: false
Debug: Arguments on startup: Debug: false and file: 
INITIALIZED in tracks
reset settings
Playlist DB is version 
DB: No change in playlist.
callbacks 0xb3e3dead 0xb3e3de59
creating surface at (0, 58) with size (768, 1222) with title 'qmlscene: music'QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
" 
QOpenGLShader::link: "--From Vertex Shader:
--From Fragment Shader:
Link was successful.
"
}}}

test-log: {{{
06:56:59.283 INFO globals:57 - ************************************************************
06:56:59.284 INFO globals:58 - Starting test music_app.tests.test_music.TestMainWindow.test_reads_music_library (with touch)
06:56:59.285 WARNING testcase:115 - No tracing available - install the python-autopilot-trace package!
06:56:59.289 WARNING testcase:152 - Process manager backend unavailable, application snapshot support disabled.
06:56:59.291 DEBUG __init__:98 - Running via click package
06:57:01.729 INFO _launcher:83 - Click package com.ubuntu.music_music_1.1.359 has been launched with PID 4002
06:57:44.514 ERROR proxies:410 - Introspect error on :1.82:/com/canonical/Autopilot/Introspection: dbus.exceptions.DBusException:
org.freedesktop.DBus.Error.NoReply: Message did not receive a reply (timeout by message bus)
06:57:44.515 DEBUG proxies:413 - Executing introspect queue due to error
06:57:44.526 INFO __init__:387 - dbus.DBusException while attempting to get PID for :1.81: DBusException("Could not get PID of name ':1.81': no such
name",)
06:57:45.547 INFO _launcher:258 - waiting for process to exit.
06:57:45.548 INFO _launcher:273 - Killing process 4002
06:57:45.549 INFO _launcher:276 - Appears process has already exited.
}}}

Traceback (most recent call last):
  File "/home/phablet/autopilot/music_app/tests/test_music.py", line 26, in setUp
    super(TestMainWindow, self).setUp()
  File "/home/phablet/autopilot/music_app/tests/__init__.py", line 79, in setUp
    launch()
  File "/home/phablet/autopilot/music_app/tests/__init__.py", line 101, in launch_test_click
    emulator_base=toolkit_emulators.UbuntuUIToolkitEmulatorBase)
  File "/usr/lib/python2.7/dist-packages/autopilot/testcase.py", line 291, in launch_click_package
    app_uris)
  File "/usr/lib/python2.7/dist-packages/autopilot/testcase.py", line 314, in _launch_test_application
    application_name=application_name,
  File "/usr/lib/python2.7/dist-packages/autopilot/introspection/__init__.py", line 154, in get_proxy_object_for_existing_process
    process
  File "/usr/lib/python2.7/dist-packages/autopilot/introspection/__init__.py", line 283, in _get_dbus_addresses_from_search_parameters
    object_path
  File "/usr/lib/python2.7/dist-packages/autopilot/introspection/__init__.py", line 309, in _search_for_valid_connections
    object_path
  File "/usr/lib/python2.7/dist-packages/autopilot/introspection/__init__.py", line 321, in _get_valid_connections
    valid_connections = filter(filter_fn, connections)
  File "/usr/lib/python2.7/dist-packages/autopilot/introspection/__init__.py", line 367, in _match_connection
    success = _connection_matches_pid(bus, connection_name, pid)
  File "/usr/lib/python2.7/dist-packages/autopilot/introspection/__init__.py", line 389, in _connection_matches_pid
    eligible_pids = [pid] + _get_child_pids(pid)
  File "/usr/lib/python2.7/dist-packages/autopilot/introspection/__init__.py", line 437, in __call__
    p.pid for p in psutil.Process(pid).get_children(recursive=True)
  File "/usr/lib/python2.7/dist-packages/psutil/__init__.py", line 232, in __init__
    raise NoSuchProcess(pid, None, 'no process found with pid %s' % pid)
NoSuchProcess: no process found with pid 4002

command_type
testcase_test