Testcase: test_edit_preset_must_update_preset

Build #:238:20140314.1: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 15 02:53:13 ubuntu-phablet kernel: [  215.003509] bq27541_get_psp voltage_now= 4128000 uV
Mar 15 02:53:13 ubuntu-phablet kernel: [  215.004821] bq27541_get_psp status: Charging ret= 0x0101
Mar 15 02:53:13 ubuntu-phablet kernel: [  215.006347] bq27541_get_psp current = -218 mA
Mar 15 02:53:13 ubuntu-phablet kernel: [  215.006988] bq27541_get_psp voltage_now= 4128000 uV
Mar 15 02:53:13 ubuntu-phablet kernel: [  215.007629] bq27541_get_capacity = 90% ret= 89
Mar 15 02:53:13 ubuntu-phablet kernel: [  215.008270] bq27541_get_psp temperature= 196 (0.1¢XC)
Mar 15 02:53:29 ubuntu-phablet kernel: [  230.690917] wlan: [1134:E :SME] csrMoveTempScanResultsToMainList: 2908: 11d AP Bssid 00:21:d8:49:c8:ef chan=
149, rssi = -71, countryCode US
Mar 15 02:53:29 ubuntu-phablet kernel: [  230.693634] wlan: [1134:E :SME] csrMoveTempScanResultsToMainList: 2908: 11d AP Bssid 00:21:d8:49:c8:ee chan=
149, rssi = -69, countryCode US
Mar 15 02:53:29 ubuntu-phablet kernel: [  230.694213] wlan: [1134:E :SME] csrMoveTempScanResultsToMainList: 2908: 11d AP Bssid 00:21:d8:49:c8:ec chan=
149, rssi = -68, countryCode US
Mar 15 02:53:29 ubuntu-phablet kernel: [  230.694793] wlan: [1134:E :SME] csrMoveTempScanResultsToMainList: 2908: 11d AP Bssid 00:21:d8:49:c8:e5 chan=
1, rssi = -61, countryCode US
Mar 15 02:53:29 ubuntu-phablet kernel: [  230.695373] wlan: [1134:E :SME] csrMoveTempScanResultsToMainList: 2908: 11d AP Bssid 74:91:1a:28:c5:dd chan=
161, rssi = -53, countryCode US
Mar 15 02:53:29 ubuntu-phablet kernel: [  230.695831] wlan: [1134:E :SME] csrMoveTempScanResultsToMainList: 2928: Information about current country
Bssid 74:91:1a:28:c5:dd chan= 161, rssi = -53, countryCode US
}}}

Application Log: {{{
libust[2737/2739]: Error: Error opening shm /lttng-ust-wait-5 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[2737/2739]: Error: Error opening shm /lttng-ust-wait-5 (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:2737): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

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

(process:2737): 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[2989/2991]: Error: Error opening shm /lttng-ust-wait-5 (in
get_wait_shm() at lttng-ust-comm.c:881)
libust[2989/2992]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[2989/2992]: Error: Error opening shm /lttng-ust-wait-5-32011 (in get_wait_shm() at lttng-ust-comm.c:881)
libust[2989/2991]: Error: Error opening shm /lttng-ust-wait-5 (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:2989): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

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

(process:2989): 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[3350/3353]: Error: Error opening shm /lttng-ust-wait-5-32011 (in
get_wait_shm() at lttng-ust-comm.c:881)
libust[3350/3353]: 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:3350): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

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

(process:3350): 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[3474/3477]: Error: Error opening shm /lttng-ust-wait-5-32011 (in
get_wait_shm() at lttng-ust-comm.c:881)
libust[3474/3477]: 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:3474): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

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

(process:3474): 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[3623/3626]: Error: Error opening shm /lttng-ust-wait-5-32011 (in
get_wait_shm() at lttng-ust-comm.c:881)
libust[3623/3626]: 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:3623): dconf-CRITICAL **: unable to create file '/run/user/32011/dconf/user': Permission denied.  dconf will not work properly.

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

(process:3623): 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: {{{
02:53:08.547 INFO globals:57 - ************************************************************
02:53:08.560 INFO globals:58 - Starting test ubuntu_clock_app.tests.test_timer.TestTimer.test_edit_preset_must_update_preset
02:53:08.562 WARNING testcase:115 - No tracing available - install the python-autopilot-trace package!
02:53:08.568 WARNING testcase:152 - Process manager backend unavailable, application snapshot support disabled.
02:53:08.570 DEBUG __init__:103 - Backed up database
02:53:11.591 INFO _launcher:83 - Click package com.ubuntu.clock_clock_1.0.373 has been launched with PID 3623
02:53:13.989 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:14.099 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:14.180 INFO logging:45 - MainView: Open the Timer tab. Arguments (). Keyword arguments: {}.
02:53:14.181 INFO logging:45 - MainView: Open a tab. Arguments ('TimerTab',). Keyword arguments: {}.
02:53:14.182 DEBUG dbus:432 - Selecting objects of type Tabs with attributes: {}
02:53:14.210 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
02:53:14.396 INFO logging:45 - MainView: Open a tab. Arguments (2,). Keyword arguments: {}.
02:53:14.397 DEBUG emulators:141 - Switch to tab with index 2.
02:53:14.397 DEBUG dbus:432 - Selecting objects of type Tabs with attributes: {}
02:53:14.429 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
02:53:14.542 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
02:53:14.770 DEBUG emulators:150 - Current tab index: 0.
02:53:14.771 INFO logging:45 - MainView: Open the next tab. Arguments (). Keyword arguments: {}.
02:53:14.772 DEBUG emulators:126 - Switch to next tab.
02:53:14.772 DEBUG dbus:432 - Selecting objects of type Header with attributes: {'objectName': 'MainView_Header'}
02:53:14.990 INFO logging:45 - Header: Open the next tab. Arguments (). Keyword arguments: {}.
02:53:14.993 DEBUG dbus:432 - Selecting objects of type TabBar with attributes: {}
02:53:15.077 INFO logging:45 - TabBar: Open the next tab. Arguments (). Keyword arguments: {}.
02:53:15.110 DEBUG emulators:350 - Already in selection mode.
02:53:15.111 DEBUG emulators:345 - Click the next tab bar button.
02:53:15.112 DEBUG dbus:432 - Selecting objects of type QQuickPathView with attributes: {}
02:53:15.185 DEBUG dbus:432 - Selecting objects of type AbstractButton with attributes: {}
02:53:15.401 DEBUG dbus:432 - Selecting objects of type AbstractButton with attributes: {}
02:53:15.791 DEBUG _common:45 - Moving to object's globalRect coordinates.
02:53:15.792 DEBUG _uinput:475 - Tapping at: 334,125
02:53:15.894 DEBUG dbus:432 - Selecting objects of type TabBarStyle with attributes: {}
02:53:17.400 DEBUG dbus:432 - Selecting objects of type Tabs with attributes: {}
02:53:17.483 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
02:53:17.735 DEBUG emulators:150 - Current tab index: 1.
02:53:17.736 INFO logging:45 - MainView: Open the next tab. Arguments (). Keyword arguments: {}.
02:53:17.737 DEBUG emulators:126 - Switch to next tab.
02:53:17.737 DEBUG dbus:432 - Selecting objects of type Header with attributes: {'objectName': 'MainView_Header'}
02:53:17.960 INFO logging:45 - Header: Open the next tab. Arguments (). Keyword arguments: {}.
02:53:17.961 DEBUG dbus:432 - Selecting objects of type TabBar with attributes: {}
02:53:17.999 INFO logging:45 - TabBar: Open the next tab. Arguments (). Keyword arguments: {}.
02:53:18.034 DEBUG emulators:353 - Click the tab bar to enable selection mode.
02:53:18.063 DEBUG _common:45 - Moving to object's globalRect coordinates.
02:53:18.064 DEBUG _uinput:475 - Tapping at: 600,125
02:53:18.166 DEBUG emulators:345 - Click the next tab bar button.
02:53:18.167 DEBUG dbus:432 - Selecting objects of type QQuickPathView with attributes: {}
02:53:18.291 DEBUG dbus:432 - Selecting objects of type AbstractButton with attributes: {}
02:53:18.539 DEBUG dbus:432 - Selecting objects of type AbstractButton with attributes: {}
02:53:19.160 DEBUG _common:45 - Moving to object's globalRect coordinates.
02:53:19.161 DEBUG _uinput:475 - Tapping at: 347,125
02:53:19.263 DEBUG dbus:432 - Selecting objects of type TabBarStyle with attributes: {}
02:53:21.190 DEBUG dbus:432 - Selecting objects of type Tabs with attributes: {}
02:53:21.284 DEBUG dbus:432 - Selecting objects of type Tab with attributes: {}
02:53:21.683 DEBUG dbus:432 - Selecting objects of type TimerPage with attributes: {}
02:53:21.769 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:21.828 DEBUG dbus:432 - Selecting objects of type QQuickListView with attributes: {}
02:53:22.017 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTextLabel0'}
02:53:22.281 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:22.402 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTimerLabel0'}
02:53:22.685 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:22.814 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTextLabel1'}
02:53:23.083 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:23.199 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTimerLabel1'}
02:53:23.413 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:23.479 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTextLabel2'}
02:53:23.694 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:23.764 DEBUG dbus:432 - Selecting objects of type Label with attributes: {'objectName': 'presetTimerLabel2'}
02:53:24.045 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:24.210 INFO logging:45 - TimerPage: Edit timer preset. Arguments (u'Soft-boiled eggEdit', 0). Keyword arguments: {}.
02:53:24.261 DEBUG dbus:432 - Selecting objects of type QQuickFlickable with attributes: {'objectName': 'animationContainer'}
02:53:24.546 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:24.743 DEBUG _uinput:546 - Dragging from 600,989 to 600,369
02:53:25.387 DEBUG dbus:432 - Selecting objects of type QQuickFlickable with attributes: {'objectName': 'animationContainer'}
02:53:25.698 DEBUG dbus:432 - Selecting objects of type MainView with attributes: {}
02:53:27.017 DEBUG dbus:432 - Selecting objects of type QQuickListView with attributes: {'objectName': 'listTimerPreset'}
02:53:27.290 INFO logging:45 - QQuickListView: Click an element from the list. Arguments ('preset0',). Keyword arguments: {}.
02:53:27.291 DEBUG dbus:432 - Selecting objects of any type with attributes: {'objectName': 'preset0'}
02:53:27.446 DEBUG dbus:432 - Selecting objects of any type with attributes: {'objectName': 'preset0'}
02:53:27.950 DEBUG dbus:432 - Selecting objects of any type with attributes: {'objectName': 'preset0'}
02:53:28.167 DEBUG _common:45 - Moving to object's globalRect coordinates.
02:53:28.168 DEBUG _uinput:475 - Tapping at: 600,1436
02:53:28.270 DEBUG dbus:432 - Selecting objects of type LabelDots with attributes: {'objectName': 'namePreset'}
02:53:28.547 DEBUG _common:45 - Moving to object's globalRect coordinates.
02:53:28.548 DEBUG _uinput:475 - Tapping at: 600,794
02:53:39.510 INFO _launcher:264 - waiting for process to exit.
02:53:39.512 INFO _launcher:279 - Killing process 3623
}}}

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