Testcase: test_edit_preset_must_update_preset

Build #:256:20140324:20140304
Arch:flo (Nexus 7 2013)
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_edit_preset_must_update_preset
testsuite
ubuntu_clock_app.tests.test_timer.TestTimer
returncode
1
command
autopilot
stderr
_StringException: /var/log/syslog: {{{
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.491577] bq27541_get_psp status: Charging ret= 0x0101
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.492187] bq27541_get_psp status: Charging ret= 0x0101
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.492828] bq27541_get_psp voltage_now= 4091000 uV
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.493408] bq27541_get_capacity = 88% ret= 87
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.493957] bq27541_get_psp temperature= 211 (0.1¢XC)
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.495056] bq27541_get_psp current = -557 mA
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.496337] bq27541_get_psp status: Charging ret= 0x0101
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.496917] bq27541_get_psp voltage_now= 4091000 uV
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.497467] bq27541_get_capacity = 88% ret= 87
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.498565] bq27541_get_capacity check capacity, cap = 2941, smb_retry = 0
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.498901] bq27541_get_psp error: temperature ret=4091, old_temp=211 
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.498901] bq27541_get_psp temperature= 211 (0.1¢XC)
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.501434] bq27541_get_capacity check capacity, cap = 64979, smb_retry = 1
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.503417] bq27541_get_capacity check capacity, cap = 64979, smb_retry = 2
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.503448] bq27541_get_capacity use old capacity=88
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.503967] bq27541_get_psp current = 698 mA
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.505462] bq27541_get_psp voltage_now= 4091000 uV
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.505950] bq27541_get_psp status: Charging ret= 0x0d47
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.507965] bq27541_get_psp voltage_now= 4091000 uV
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.508758] bq27541_get_psp current = 87 mA
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.509277] bq27541_get_capacity = 100% ret= 100
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.510803] bq27541_get_psp temperature= 211 (0.1¢XC)
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.511688] bq27541_get_psp error: temperature ret=4091, old_temp=211 
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.511688] bq27541_get_psp temperature= 211 (0.1¢XC)
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.512786] bq27541_get_psp status: Full ret= 0xfdd3
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.513397] healthd: battery l=88 v=4091 t=21.1 h=2 st=5 c=0 chg=u
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.514373] bq27541_get_psp current = -557 mA
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.517028] bq27541_get_psp status: Full ret= 0x0101
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.517608] bq27541_get_psp voltage_now= 4091000 uV
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.518157] bq27541_get_capacity = 88% ret= 87
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.518707] bq27541_get_psp temperature= 211 (0.1¢XC)
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.520416] bq27541_get_psp current = -557 mA
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.534454] bq27541_get_psp voltage_now= 4091000 uV
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.538574] bq27541_get_psp status: Charging ret= 0x0101
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.543701] bq27541_get_psp current = -557 mA
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.544342] bq27541_get_psp voltage_now= 4091000 uV
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.544982] bq27541_get_capacity = 88% ret= 87
Mar 24 19:49:52 ubuntu-phablet kernel: [  184.545623] bq27541_get_psp temperature= 211 (0.1¢XC)
Mar 24 19:49:53 ubuntu-phablet kernel: [  184.629943] smb345_charger: [smb345_config_thermal_limit] Bypass set HRD SFT limit=73
Mar 24 19:49:53 ubuntu-phablet kernel: [  184.630187] smb345_charger: [smb345_config_thermal_charging] temp=21, volt=4116000
Mar 24 19:49:53 ubuntu-phablet kernel: [  184.630554] smb345_charger: [smb345_config_thermal_charging] Bypass set Float Volt=e8
Mar 24 19:49:53 ubuntu-phablet kernel: [  184.630828] smb345_charger: [smb345_config_thermal_charging] Bypass charger enable
}}}

Application Log: {{{
libust[2681/2683]: Error: Error opening shm /lttng-ust-wait-5 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[2681/2683]: Error: Error opening shm /lttng-ust-wait-5 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[2681/2684]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[2681/2684]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
Testability driver loaded. Wire protocol version is "1.4".
virtual QString QOrganizerEDSFactory::managerName() const 
virtual QtOrganizer::QOrganizerManagerEngine* QOrganizerEDSFactory::engine(const QMap<QString, QString>&, QtOrganizer::QOrganizerManager::Error*) eds 

(process:2681): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:2681): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:2681): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.
creating surface at (0, 58) with size (1200, 1862) with title 'qmlscene: clock'libust[2839/2841]: Error: Error opening shm /lttng-ust-wait-5 (in
get_wait_shm() at lttng-ust-comm.c:881)
libust[2839/2841]: Error: Error opening shm /lttng-ust-wait-5 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[2839/2842]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[2839/2842]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
Testability driver loaded. Wire protocol version is "1.4".
virtual QString QOrganizerEDSFactory::managerName() const 
virtual QtOrganizer::QOrganizerManagerEngine* QOrganizerEDSFactory::engine(const QMap<QString, QString>&, QtOrganizer::QOrganizerManager::Error*) eds 

(process:2839): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:2839): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:2839): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.
creating surface at (0, 58) with size (1200, 1862) with title 'qmlscene: clock'libust[3208/3211]: Error: Error opening shm /lttng-ust-wait-5-32011 (in
get_wait_shm() at lttng-ust-comm.c:881)
libust[3208/3211]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
Testability driver loaded. Wire protocol version is "1.4".
virtual QString QOrganizerEDSFactory::managerName() const 
virtual QtOrganizer::QOrganizerManagerEngine* QOrganizerEDSFactory::engine(const QMap<QString, QString>&, QtOrganizer::QOrganizerManager::Error*) eds 

(process:3208): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:3208): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:3208): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.
creating surface at (0, 58) with size (1200, 1862) with title 'qmlscene: clock'libust[3307/3310]: Error: Error opening shm /lttng-ust-wait-5-32011 (in
get_wait_shm() at lttng-ust-comm.c:881)
libust[3307/3310]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
Testability driver loaded. Wire protocol version is "1.4".
virtual QString QOrganizerEDSFactory::managerName() const 
virtual QtOrganizer::QOrganizerManagerEngine* QOrganizerEDSFactory::engine(const QMap<QString, QString>&, QtOrganizer::QOrganizerManager::Error*) eds 

(process:3307): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:3307): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:3307): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.
creating surface at (0, 58) with size (1200, 1862) with title 'qmlscene: clock'libust[3429/3431]: Error: Error opening shm /lttng-ust-wait-5 (in
get_wait_shm() at lttng-ust-comm.c:881)
libust[3429/3431]: Error: Error opening shm /lttng-ust-wait-5 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[3429/3432]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[3429/3432]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
Testability driver loaded. Wire protocol version is "1.4".
virtual QString QOrganizerEDSFactory::managerName() const 
virtual QtOrganizer::QOrganizerManagerEngine* QOrganizerEDSFactory::engine(const QMap<QString, QString>&, QtOrganizer::QOrganizerManager::Error*) eds 

(process:3429): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:3429): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

(process:3429): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.
creating surface at (0, 58) with size (1200, 1862) with title 'qmlscene: clock'
}}}

test-log: {{{
19:49:37.227 INFO globals:58 - ************************************************************
19:49:37.228 INFO globals:59 - Starting test ubuntu_clock_app.tests.test_timer.TestTimer.test_edit_preset_must_update_preset
19:49:37.229 WARNING testcase:117 - No tracing available - install the python-autopilot-trace package!
19:49:37.235 WARNING testcase:155 - Process manager backend unavailable, application snapshot support disabled.
19:49:37.237 DEBUG __init__:103 - Backed up database
19:49:37.272 INFO testcase:305 - Attempting to launch click application '(default)' from click package  'com.ubuntu.clock' and URIs ''
19:49:41.183 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:41.340 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:41.369 INFO logging:45 - MainView: Open the Timer tab. Arguments (). Keyword arguments: {}.
19:49:41.370 INFO logging:45 - MainView: Open a tab. Arguments ('TimerTab',). Keyword arguments: {}.
19:49:41.370 DEBUG dbus:432 - Selecting objects of type Tabs with attributes: {}
19:49:41.396 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
19:49:41.588 INFO logging:45 - MainView: Open a tab. Arguments (2,). Keyword arguments: {}.
19:49:41.589 DEBUG emulators:141 - Switch to tab with index 2.
19:49:41.589 DEBUG dbus:432 - Selecting objects of type Tabs with attributes: {}
19:49:41.646 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
19:49:41.750 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
19:49:41.947 DEBUG emulators:150 - Current tab index: 0.
19:49:41.948 INFO logging:45 - MainView: Open the next tab. Arguments (). Keyword arguments: {}.
19:49:41.948 DEBUG emulators:126 - Switch to next tab.
19:49:41.949 DEBUG dbus:432 - Selecting objects of type Header with attributes: {'objectName': 'MainView_Header'}
19:49:42.171 INFO logging:45 - Header: Open the next tab. Arguments (). Keyword arguments: {}.
19:49:42.172 DEBUG dbus:432 - Selecting objects of type TabBar with attributes: {}
19:49:42.209 INFO logging:45 - TabBar: Open the next tab. Arguments (). Keyword arguments: {}.
19:49:42.256 DEBUG emulators:350 - Already in selection mode.
19:49:42.256 DEBUG emulators:345 - Click the next tab bar button.
19:49:42.257 DEBUG dbus:432 - Selecting objects of type QQuickPathView with attributes: {}
19:49:42.351 DEBUG dbus:432 - Selecting objects of type AbstractButton with attributes: {}
19:49:42.600 DEBUG dbus:432 - Selecting objects of type AbstractButton with attributes: {}
19:49:42.948 DEBUG _common:45 - Moving to object's globalRect coordinates.
19:49:42.949 DEBUG _uinput:475 - Tapping at: 334,125
19:49:43.050 DEBUG dbus:432 - Selecting objects of type TabBarStyle with attributes: {}
19:49:44.561 DEBUG dbus:432 - Selecting objects of type Tabs with attributes: {}
19:49:44.634 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
19:49:44.891 DEBUG emulators:150 - Current tab index: 1.
19:49:44.892 INFO logging:45 - MainView: Open the next tab. Arguments (). Keyword arguments: {}.
19:49:44.892 DEBUG emulators:126 - Switch to next tab.
19:49:44.893 DEBUG dbus:432 - Selecting objects of type Header with attributes: {'objectName': 'MainView_Header'}
19:49:45.108 INFO logging:45 - Header: Open the next tab. Arguments (). Keyword arguments: {}.
19:49:45.109 DEBUG dbus:432 - Selecting objects of type TabBar with attributes: {}
19:49:45.146 INFO logging:45 - TabBar: Open the next tab. Arguments (). Keyword arguments: {}.
19:49:45.180 DEBUG emulators:353 - Click the tab bar to enable selection mode.
19:49:45.215 DEBUG _common:45 - Moving to object's globalRect coordinates.
19:49:45.216 DEBUG _uinput:475 - Tapping at: 600,125
19:49:45.318 DEBUG emulators:345 - Click the next tab bar button.
19:49:45.319 DEBUG dbus:432 - Selecting objects of type QQuickPathView with attributes: {}
19:49:45.459 DEBUG dbus:432 - Selecting objects of type AbstractButton with attributes: {}
19:49:45.711 DEBUG dbus:432 - Selecting objects of type AbstractButton with attributes: {}
19:49:46.169 DEBUG _common:45 - Moving to object's globalRect coordinates.
19:49:46.170 DEBUG _uinput:475 - Tapping at: 347,125
19:49:46.271 DEBUG dbus:432 - Selecting objects of type TabBarStyle with attributes: {}
19:49:48.151 DEBUG dbus:432 - Selecting objects of type Tabs with attributes: {}
19:49:48.250 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
19:49:48.655 DEBUG dbus:432 - Selecting objects of type TimerPage with attributes: {}
19:49:48.721 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:48.780 DEBUG dbus:432 - Selecting objects of type QQuickListView with attributes: {}
19:49:48.969 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTextLabel0'}
19:49:49.237 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:49.359 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTimerLabel0'}
19:49:49.611 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:49.672 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTextLabel1'}
19:49:49.885 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:49.950 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTimerLabel1'}
19:49:50.171 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:50.235 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTextLabel2'}
19:49:50.447 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:50.512 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTimerLabel2'}
19:49:50.727 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:50.796 INFO logging:45 - TimerPage: Edit timer preset. Arguments (u'Soft-boiled eggEdit', 0). Keyword arguments: {}.
19:49:50.828 DEBUG dbus:432 - Selecting objects of type QQuickFlickable with attributes: {'objectName': 'animationContainer'}
19:49:51.073 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:51.229 DEBUG _uinput:546 - Dragging from 600,989 to 600,369
19:49:51.872 DEBUG dbus:432 - Selecting objects of type QQuickFlickable with attributes: {'objectName': 'animationContainer'}
19:49:52.164 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
19:49:53.529 DEBUG dbus:432 - Selecting objects of type QQuickListView with attributes: {'objectName': 'listTimerPreset'}
19:49:53.792 INFO logging:45 - QQuickListView: Click an element from the list. Arguments ('preset0',). Keyword arguments: {}.
19:49:53.793 DEBUG dbus:432 - Selecting objects of any type with attributes: {'objectName': 'preset0'}
19:49:53.958 DEBUG dbus:432 - Selecting objects of any type with attributes: {'objectName': 'preset0'}
19:49:54.453 DEBUG dbus:432 - Selecting objects of any type with attributes: {'objectName': 'preset0'}
19:49:54.586 DEBUG _common:45 - Moving to object's globalRect coordinates.
19:49:54.587 DEBUG _uinput:475 - Tapping at: 600,1436
19:49:54.691 DEBUG dbus:432 - Selecting objects of type LabelDots with attributes: {'objectName': 'namePreset'}
19:49:54.963 DEBUG _common:45 - Moving to object's globalRect coordinates.
19:49:54.964 DEBUG _uinput:475 - Tapping at: 600,794
}}}

Traceback (most recent call last):
  File "/home/phablet/autopilot/ubuntu_clock_app/tests/test_timer.py", line 83, in test_edit_preset_must_update_preset
    self.page.edit_preset_timer(edited_name, timer_index)
  File "/usr/lib/python2.7/dist-packages/autopilot/logging.py", line 46, in inner
    return f(instance, *args, **kwargs)
  File "/home/phablet/autopilot/ubuntu_clock_app/emulators.py", line 837, in edit_preset_timer
    self._set_timer_name(name)
  File "/home/phablet/autopilot/ubuntu_clock_app/emulators.py", line 727, in _set_timer_name
    name_label.write(name)
  File "/home/phablet/autopilot/ubuntuuitoolkit/emulators.py", line 473, in write
    self.focus.wait_for(True)
  File "/usr/lib/python2.7/dist-packages/autopilot/introspection/types.py", line 181, in wait_for
    failure_msg))
AssertionError: After 10.0 seconds test on LabelDots.focus failed: True != dbus.Boolean(False, variant_level=1)

command_type
testcase_test