[Announce] CSSU Testing thread

Member's Online

Page 149 of 189 | Prev | 139 147 148 149 150 151 159 | Next | Last

pali | # 1481 | 2013-08-18, 18:06 | Report

@cr0c0: there is no proper fix yet. My above packages removing compatibility with upstream desktop pulseaudio version which break other things... I will try to fix it properly, but now I do not have time :-(

Android_808 | # 1482 | 2013-08-18, 18:36 | Report

After a little feedback regarding last CSSU-T/T-Thumb:

Is there anyone having problems with bluetooth browsing? More specifically, I' using XFCE + Blueman + Thunar from Arch stable on an Eee 1000. I'm unable to view phone contents, getting Unable to open "File System" - Connection lost. Sending files is working ok.

Thought I'd ask before setting up syslog and friends.

Edit: setup syslog and bluetooth logging, no obvious errors. xx:.. is desktop, yy: mobile.

Code:

Aug 19 21:28:48 Nokia-N900 obexd[4420]: bluetooth: New connection from: xx:xx:xx:xx:xx:xx, channel 24
Aug 19 21:28:48 Nokia-N900 obexd[4420]: plugins/bluetooth.c:find_adapter() FindAdapter(yy:yy:yy:yy:yy:yy)
Aug 19 21:28:48 Nokia-N900 obexd[4420]: plugins/bluetooth.c:find_adapter_reply() FindAdapter -> /org/bluez/1165/hci0
Aug 19 21:28:48 Nokia-N900 obexd[4420]: plugins/bluetooth.c:find_adapter_reply() RequestAuthorization(xx:xx:xx:xx:xx:xx, 10006)
Aug 19 21:28:48 Nokia-N900 obexd[4420]: plugins/bluetooth.c:service_reply() RequestAuthorization succeeded
Aug 19 21:28:48 Nokia-N900 obexd[4420]: src/obex.c:obex_session_start() 
Aug 19 21:28:57 Nokia-N900 obexd[4420]: disconnected: Transport got disconnected 
Aug 19 21:28:57 Nokia-N900 obexd[4420]: src/obex.c:obex_session_destroy() 
Aug 19 21:29:48 Nokia-N900 obexd[4420]: Terminating

hcidump from laptop:

Code:

HCI sniffer - Bluetooth packet analyzer ver 5.7
device: hci0 snap_len: 1500 filter: 0xffffffff
> HCI Event: Command Status (0x0f) plen 4
    Create Connection (0x01|0x0005) status 0x00 ncmd 1
> HCI Event: Connect Complete (0x03) plen 11
    status 0x00 handle 11 bdaddr YY:YY:YY:YY:YY:YY type ACL encrypt 0x00
> HCI Event: Command Status (0x0f) plen 4
    Read Remote Supported Features (0x01|0x001b) status 0x00 ncmd 1
> HCI Event: Read Remote Supported Features (0x0b) plen 11
    status 0x00 handle 11
    Features: 0xbf 0xee 0x0f 0xc6 0x98 0x3d 0x59 0x82
> HCI Event: Command Status (0x0f) plen 4
    Read Remote Extended Features (0x01|0x001c) status 0x00 ncmd 1
> HCI Event: Read Remote Extended Features (0x23) plen 13
    status 0x00 handle 11 page 1 max 1
    Features: 0x01 0x00 0x00 0x00 0x00 0x00 0x00 0x00
> HCI Event: Command Status (0x0f) plen 4
    Remote Name Request (0x01|0x0019) status 0x00 ncmd 1
> HCI Event: Remote Name Req Complete (0x07) plen 255
    status 0x00 bdaddr YY:YY:YY:YY:YY:YY name 'Nokia N900'
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Status (0x0f) plen 4
    Authentication Requested (0x01|0x0011) status 0x00 ncmd 1
> HCI Event: Command Complete (0x0e) plen 10
    Link Key Request Reply (0x01|0x000b) ncmd 1
    status 0x00 bdaddr YY:YY:YY:YY:YY:YY
> HCI Event: Auth Complete (0x06) plen 3
    status 0x00 handle 11
> HCI Event: Command Status (0x0f) plen 4
    Set Connection Encryption (0x01|0x0013) status 0x00 ncmd 1
> HCI Event: Encrypt Change (0x08) plen 4
    status 0x00 handle 11 encrypt 0x01
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Complete (0x0e) plen 7
    Read RSSI (0x05|0x0005) ncmd 1
    status 0x00 handle 11 rssi 0
> HCI Event: Command Complete (0x0e) plen 7
    Read Link Quality (0x05|0x0003) ncmd 1
    status 0x00 handle 11 lq 255
> HCI Event: Command Complete (0x0e) plen 7
    Read Transmit Power Level (0x03|0x002d) ncmd 1
    status 0x00 handle 11 level 3
> HCI Event: Command Status (0x0f) plen 4
    Disconnect (0x01|0x0006) status 0x00 ncmd 1
> HCI Event: Disconn Complete (0x05) plen 4
    status 0x00 handle 11 reason 0x16
    Reason: Connection Terminated by Local Host

Last edited by Android_808; 2013-08-19 at 20:43.

The Following 3 Users Say Thank You to Android_808 For This Useful Post:
Amboss, Estel, luf

tanago | # 1483 | 2013-08-23, 18:09 | Report

I'd like to report high battery usage when phone is locked & idle.

So long story short - I spotted that phone lasts ~2 days without any usage. -70 mA/h when idling

Steps to reproduce:
Inspect battery usage for stock Maemo 5 and CSSU T with bq27200.sh script (credits to shadowjk)

I did:
1. Reflash phone eMMC + rootfs, update to latest official Maemo 5 (21.2011.38-1) , test battery usage: Idle unlocked (-115 mA/h) Idle locked (-20~25 mA/h)

2. install kernel-power v52, maximum stable undervolting without overclocking(250-600), test battery usage: Idle unlocked (-105 mA/h) Idle locked(-17mA/h)

3. Install CSSU Testing, test battery usage: Idle unlocked(-123 mA/h), Idle locked( -71 mA/h)

comparing v21.2011 and CSSU-T (17mAh vs 71 mAh) that's 4 times+ less lifetime of the battery for one charge

Tried
-Install CSSU Thumb
-Offline mode
-Reboot phone several times

I havent tried these which might help
-Reflash again and try CSSU Stable
-Battery Patch

To inspect battery usage

you need i2c-tools and bq27200.sh script

cp bq27200.sh to /usr/bin
chmod +x /usr/bin/bq27200.sh

then
sudo gainroot
bq27200.sh 5

leave only the XTerm running and lock the phone, unlock after 30 seconds and take a look at the fifth column, thats the mA/h

The Following 5 Users Say Thank You to tanago For This Useful Post:
Amboss, foobar, freemangordon, handaxe, petur

handaxe | # 1484 | 2013-08-23, 20:19 | Report

Originally Posted by tanago View Post

I havent tried these which might help
-Reflash again and try CSSU Stable
-Battery Patch

This seems a good report - thorough.

As for Battery Patch the consensus seems to be NOOOOOOO!

Have you tried using powertop on the 3 different configs? Might show where the difference lies.

The Following 2 Users Say Thank You to handaxe For This Useful Post:
sixwheeledbeast, tanago

Android_808 | # 1485 | 2013-08-24, 07:42 | Report

another potential issue I'm experiencing another random, hard to reproduce issue ffor last week or so.

Whilst browsing web with microb, device loses track of focus. You can happily be browsing away and then it loads next page and nothing works. clicking/scrolling page results in haptic feedback but nothing else. text box is unresponsive. keyboard has no effect.

my initial reaction was unresponsive due to load but that usually slows haptic response as well. I then found that the task switcher button still works. you can get out to desktop but widgets don't work. you can get to menu and launch apps but they fail to respond to input. power button launched its menu but desaturated and unresponsive....

then i turned screen off with slider on the side, turn it on again using the slider and everything starts working again.

The Following 2 Users Say Thank You to Android_808 For This Useful Post:
Amboss, peterleinchen

tanago | # 1486 | 2013-08-24, 12:10 | Report

Reflashed again

Maemo 5 latest official, normal 15-20mAh when idling:

Code:

Powertop 1.13.3
Sleeping for 11 seconds before sampling
Collecting data for 30 seconds
Sample interval was 00m 30s 28167us

C#      | Ratio  | Avg/dura | Frequency | Ratio
--------+--------+----------+-----------+--------+
     C0 |   7.5% |          |  1150 MHz |   nan% |
     C1 |   0.0% |    0.2ms | 
     C2 |   3.7% |    4.5ms | 
     C3 |  30.9% |   91.8ms | 
     C4 |  57.9% | 1241.8ms | 

IRQ#    | Activity   | Type           | Name
--------+------------+----------------+---------------------------
     37 |        472 |           INTC | gp
     57 |        273 |           INTC | i2c_omap
     11 |        246 |           INTC | prcm
     56 |        244 |           INTC | i2c_omap
     21 |         59 |           INTC | SGX
     86 |         33 |           INTC | mmc1
     67 |         12 |           INTC | ssi_p1_mpu_irq0
     71 |          8 |           INTC | ssi_gdd
     12 |          5 |           INTC | DMA
    311 |          4 |           GPIO | ssi_p1_cawake_gpio

PID#    | Activity   | Name           | Function Entry (Expire)
--------+------------+----------------+---------------------------
      0 |        300 |  <kernel core> | tick_nohz_restart_sched_tick (tick_sched_timer)
   1606 |        114 |     osso-xterm | schedule_hrtimeout_range (hrtimer_wakeup)
     38 |         41D|            awk | cpufreq_governor_dbs (delayed_work_timer_fn)
      0 |         18 |  <kernel core> | hrtimer_start (tick_sched_timer)
    957 |         14 |           Xorg | hrtimer_start (it_real_fn)
    909 |         12 |       sgx_perf | queue_delayed_work (delayed_work_timer_fn)
    686 |          8 |           dsme | __enqueue_rt_entity (sched_rt_period_timer)
    957 |          7 |           Xorg | queue_delayed_work (delayed_work_timer_fn)
    722 |          7 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
    597 |          5 |          mmcqd | queue_delayed_work (delayed_work_timer_fn)
      1 |          2D|  <kernel core> | queue_delayed_work (delayed_work_timer_fn)
     27 |          2 |    kondemand/0 | queue_delayed_work (delayed_work_timer_fn)
    686 |          2 |           dsme | do_nanosleep (hrtimer_wakeup)
    722 |          2 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
    722 |          2 |      bme_RX-51 | do_nanosleep (hrtimer_wakeup)
    722 |          2 |      bme_RX-51 | schedule_timeout (process_timeout)
   2228 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
     30 |          1 |          mount | setup_wb_timer (wb_timer_fn)
     14 |          1 |        pdflush | blk_plug_device (blk_unplug_timeout)
   2244 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
    855 |          1 |           hald | schedule_hrtimeout_range (hrtimer_wakeup)
   2260 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   2276 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   1345 |          1 |       trackerd | queue_delayed_work (delayed_work_timer_fn)
   2292 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
    885 |          1 |            mce | schedule_hrtimeout_range (hrtimer_wakeup)
   1546 |          1 |       browserd | futex_wait (hrtimer_wakeup)
   2308 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
    988 |          1 | hald-addon-bme | schedule_hrtimeout_range (hrtimer_wakeup)
   2192 |          1 |       powertop | do_nanosleep (hrtimer_wakeup)

Power domain activity breakdown
Domain  | % of time spent in states
--------+---------+---------+---------+---------+----------
usbhost |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    sgx |OFF:  86%|RET:   0%|INA:   0%| ON:  13%| now:(OFF)
    per |OFF:  87%|RET:   4%|INA:   0%| ON:   7%| now:(ON)
    dss |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    cam |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
   core |OFF:  57%|RET:  20%|INA:   0%| ON:  20%| now:(ON)
   neon |OFF:  57%|RET:  30%|INA:   3%| ON:   7%| now:(ON)
    mpu |OFF:  57%|RET:  30%|INA:   3%| ON:   7%| now:(ON)
   iva2 |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)

Clock activity breakdown at end of period
Domain  | Active clocks
--------+---------------+---------------+------------------
   core |          SDRC | HSOTGUSB_IDLE |      OMAPCTRL 
        |     MAILBOXES |
   wkup |          GPT1 |       32KSYNC |         GPIO1 
        |          WDT1 |           SR2 |
  ckgen |          CORE |          PERI |           96M 
        |           48M |           12M |           54M 
        |      EMU_CORE |
    per |         GPIO2 |         GPIO3 |         GPIO4 
        |         GPIO5 |         GPIO6 |

Total wakeups  1908,  63.6/s | IRQ 1356,  45.2/s | Timers  552,  18.4/s
HW wakeups      246,   8.2/s |     Real gp_timers expired  216,   7.2/s

On top of it installed CSSU-Stable, again normal 15-20mAh when idling:

Code:

Powertop 1.13.3
Sleeping for 11 seconds before sampling
Collecting data for 30 seconds
Sample interval was 00m 30s 18859us

C#      | Ratio  | Avg/dura | Frequency | Ratio
--------+--------+----------+-----------+--------+
     C0 |   7.5% |          |  1150 MHz |   nan% |
     C1 |   0.0% |    0.3ms | 
     C2 |   5.4% |    5.4ms | 
     C3 |  36.0% |  107.0ms | 
     C4 |  51.1% |  902.9ms | 

IRQ#    | Activity   | Type           | Name
--------+------------+----------------+---------------------------
     37 |        565 |           INTC | gp
     11 |        331 |           INTC | prcm
     57 |        279 |           INTC | i2c_omap
     56 |        187 |           INTC | i2c_omap
     21 |         56 |           INTC | SGX
     86 |          3 |           INTC | mmc1

PID#    | Activity   | Name           | Function Entry (Expire)
--------+------------+----------------+---------------------------
      0 |        377 |  <kernel core> | tick_nohz_restart_sched_tick (tick_sched_timer)
   1544 |        114 |     osso-xterm | schedule_hrtimeout_range (hrtimer_wakeup)
     38 |         54D|            awk | cpufreq_governor_dbs (delayed_work_timer_fn)
   1236 |         30 | hildon-desktop | schedule_hrtimeout_range (hrtimer_wakeup)
      0 |         16 |  <kernel core> | hrtimer_start (tick_sched_timer)
    954 |         12 |           Xorg | hrtimer_start (it_real_fn)
    912 |         12 |       sgx_perf | queue_delayed_work (delayed_work_timer_fn)
    691 |          9 |           dsme | __enqueue_rt_entity (sched_rt_period_timer)
    954 |          9 |           Xorg | queue_delayed_work (delayed_work_timer_fn)
    730 |          6 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
      1 |          3D|  <kernel core> | queue_delayed_work (delayed_work_timer_fn)
    602 |          2 |          mmcqd | queue_delayed_work (delayed_work_timer_fn)
    730 |          2 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
    730 |          2 |      bme_RX-51 | do_nanosleep (hrtimer_wakeup)
    730 |          2 |      bme_RX-51 | schedule_timeout (process_timeout)
    691 |          2 |           dsme | do_nanosleep (hrtimer_wakeup)
   1267 |          2D|<kernel module> | queue_delayed_work (delayed_work_timer_fn)
   1748 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   1764 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   1179 |          1 |mission-control | schedule_hrtimeout_range (hrtimer_wakeup)
   1780 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   1796 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
    864 |          1 |           hald | schedule_hrtimeout_range (hrtimer_wakeup)
   1812 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
    892 |          1 |            mce | schedule_hrtimeout_range (hrtimer_wakeup)
   1384 |          1 |          fmtxd | queue_delayed_work (delayed_work_timer_fn)
   1828 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   1713 |          1 |       powertop | do_nanosleep (hrtimer_wakeup)

Power domain activity breakdown
Domain  | % of time spent in states
--------+---------+---------+---------+---------+----------
usbhost |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    sgx |OFF:  86%|RET:   0%|INA:   0%| ON:  13%| now:(OFF)
    per |OFF:  87%|RET:   5%|INA:   0%| ON:   7%| now:(ON)
    dss |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    cam |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
   core |OFF:  51%|RET:  27%|INA:   2%| ON:  18%| now:(ON)
   neon |OFF:  51%|RET:  35%|INA:   5%| ON:   7%| now:(ON)
    mpu |OFF:  51%|RET:  35%|INA:   5%| ON:   7%| now:(ON)
   iva2 |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)

Clock activity breakdown at end of period
Domain  | Active clocks
--------+---------------+---------------+------------------
   core |          SDRC | HSOTGUSB_IDLE |      OMAPCTRL 
        |     MAILBOXES |
   wkup |          GPT1 |       32KSYNC |         GPIO1 
        |          WDT1 |           SR2 |
  ckgen |          CORE |          PERI |           96M 
        |           48M |           12M |           54M 
        |      EMU_CORE |
    per |         GPIO2 |         GPIO3 |         GPIO4 
        |         GPIO5 |         GPIO6 |

Total wakeups  2086,  69.5/s | IRQ 1421,  47.4/s | Timers  665,  22.2/s
HW wakeups       75,   2.5/s |     Real gp_timers expired   53,   1.8/s

Installed CSSU-T on top of CSSU-S, 70mAh when idling:

Code:

Powertop 1.13.3
Sleeping for 11 seconds before sampling
Collecting data for 30 seconds
Sample interval was 00m 30s 18829us

C#      | Ratio  | Avg/dura | Frequency | Ratio
--------+--------+----------+-----------+--------+
     C0 |   7.6% |          |  1150 MHz |   nan% |
     C1 |   0.0% |    0.5ms | 
     C2 |  14.7% |   16.0ms | 
     C3 |  32.9% |   94.9ms | 
     C4 |  44.8% | 1343.0ms | 

IRQ#    | Activity   | Type           | Name
--------+------------+----------------+---------------------------
     37 |        512 |           INTC | gp
     11 |        284 |           INTC | prcm
     57 |        277 |           INTC | i2c_omap
     56 |        248 |           INTC | i2c_omap
     21 |         61 |           INTC | SGX
     86 |         58 |           INTC | mmc1
     12 |         17 |           INTC | DMA

PID#    | Activity   | Name           | Function Entry (Expire)
--------+------------+----------------+---------------------------
      0 |        318 |  <kernel core> | tick_nohz_restart_sched_tick (tick_sched_timer)
   1596 |        114 |     osso-xterm | schedule_hrtimeout_range (hrtimer_wakeup)
     38 |         37D|            awk | cpufreq_governor_dbs (delayed_work_timer_fn)
      0 |         32 |  <kernel core> | hrtimer_start (tick_sched_timer)
    955 |         18 |           Xorg | hrtimer_start (it_real_fn)
    955 |         18 |           Xorg | queue_delayed_work (delayed_work_timer_fn)
    911 |         13 |       sgx_perf | queue_delayed_work (delayed_work_timer_fn)
    589 |         12 |          mmcqd | schedule_timeout (process_timeout)
    683 |         10 |           dsme | __enqueue_rt_entity (sched_rt_period_timer)
    719 |          7 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
    589 |          5 |          mmcqd | queue_delayed_work (delayed_work_timer_fn)
   1325 |          5 |        control | schedule_hrtimeout_range (hrtimer_wakeup)
    589 |          3 |          mmcqd | cfq_completed_request (cfq_idle_slice_timer)
      1 |          3D|  <kernel core> | queue_delayed_work (delayed_work_timer_fn)
    683 |          2 |           dsme | do_nanosleep (hrtimer_wakeup)
    960 |          2D|<kernel module> | queue_delayed_work (delayed_work_timer_fn)
    719 |          2 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
    719 |          2 |      bme_RX-51 | do_nanosleep (hrtimer_wakeup)
    719 |          2 |      bme_RX-51 | schedule_timeout (process_timeout)
   1953 |          2 |       browserd | futex_wait (hrtimer_wakeup)
   2273 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   1452 |          1 |<kernel module> | queue_delayed_work (delayed_work_timer_fn)
   2290 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   2306 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   2323 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
    749 |          1 |    dbus-daemon | schedule_hrtimeout_range (hrtimer_wakeup)
    887 |          1 |            mce | schedule_hrtimeout_range (hrtimer_wakeup)
   2339 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
    851 |          1 |           hald | schedule_hrtimeout_range (hrtimer_wakeup)
      1 |          1 |  <kernel core> | inet_initpeers (peer_check_expire)
   2356 |          1 |          sleep | do_nanosleep (hrtimer_wakeup)
   1079 |          1 |    dbus-daemon | schedule_hrtimeout_range (hrtimer_wakeup)
   2239 |          1 |       powertop | do_nanosleep (hrtimer_wakeup)

Power domain activity breakdown
Domain  | % of time spent in states
--------+---------+---------+---------+---------+----------
usbhost |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    sgx |OFF:  86%|RET:   0%|INA:   0%| ON:  13%| now:(OFF)
    per |OFF:  77%|RET:  14%|INA:   0%| ON:   7%| now:(ON)
    dss |OFF:   0%|RET:   0%|INA:   0%| ON: 100%| now:(ON)
    cam |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
   core |OFF:   0%|RET:   0%|INA:   0%| ON: 100%| now:(ON)
   neon |OFF:  44%|RET:  32%|INA:  14%| ON:   7%| now:(ON)
    mpu |OFF:  44%|RET:  32%|INA:  14%| ON:   7%| now:(ON)
   iva2 |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)

Clock activity breakdown at end of period
Domain  | Active clocks
--------+---------------+---------------+------------------
   core |          SDRC | HSOTGUSB_IDLE |      OMAPCTRL 
        |     MAILBOXES |
   wkup |          GPT1 |       32KSYNC |         GPIO1 
        |          WDT1 |           SR2 |
  ckgen |          CORE |          PERI |           96M 
        |           48M |           12M |           54M 
        |      EMU_CORE |
    dss |      DSS_STBY |      DSS_IDLE 
    per |         GPIO2 |         GPIO3 |         GPIO4 
        |         GPIO5 |         GPIO6 |

Total wakeups  2077,  69.2/s | IRQ 1457,  48.6/s | Timers  620,  20.7/s
HW wakeups       28,   0.9/s |     Real gp_timers expired    0,   0.0/s

After taking a look, the problem turns out to be heavy usage of 'dss' and 'core', both ON-100%.

So, i will try a few things to help lower their usage.

Any other tips and further investigating tools?

EDIT: Well, uninstalling everything+installing stock kernel doesnt lower power usage, so I guess some package in CSSU-T is not well optimized

Last edited by tanago; 2013-08-24 at 12:52.

The Following 5 Users Say Thank You to tanago For This Useful Post:
Amboss, foobar, fw190, handaxe, misiak

handaxe | # 1487 | 2013-08-24, 13:37 | Report

Originally Posted by tanago View Post

Any other tips and further investigating tools?

I think this will need a dev to decipher properly but you have provided unequivocal evidence of a non-optimal performance and great info for helping understand why.

I will run the same tests on CSSU-T (thumb) when I get the chance and see if I am in the ball-park of your device.

The Following 4 Users Say Thank You to handaxe For This Useful Post:
Amboss, fw190, misiak, tanago

freemangordon | # 1488 | 2013-08-24, 14:38 | Report

weird, I can't reproduce your high battery usage, this is my powertop output, device in offline mode:

Code:

Nokia-N900:~# powertop
Powertop 1.13.3
status: Unknown job: pmtrackerdaemon
Sleeping for 11 seconds before sampling
Collecting data for 30 seconds
Sample interval was 00m 30s 23255us

C#      | Ratio  | Avg/dura | Frequency | Ratio
--------+--------+----------+-----------+--------+
     C0 |   0.9% |          |  1150 MHz |   nan% |
     C1 |   0.0% |    0.2ms | 
     C2 |   0.4% |    3.6ms | 
     C3 |   2.4% |  178.0ms | 
     C4 |  96.3% | 1701.2ms | 

IRQ#    | Activity   | Type           | Name
--------+------------+----------------+---------------------------
     56 |         90 |           INTC | i2c_omap
     37 |         73 |           INTC | gp
     11 |         44 |           INTC | prcm
     57 |         28 |           INTC | i2c_omap
     12 |          2 |           INTC | DMA
     21 |          2 |           INTC | SGX
    225 |          2 |           GPIO | omap2-onenand

PID#    | Activity   | Name           | Function Entry (Expire)
--------+------------+----------------+---------------------------
      0 |         38 |  <kernel core> | tick_nohz_restart_sched_tick (tick_sched_timer)
     38 |         13D|            awk | cpufreq_governor_dbs (delayed_work_timer_fn)
      0 |          9 |  <kernel core> | hrtimer_start (tick_sched_timer)
    770 |          5 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
   1824 |          4 |       browserd | futex_wait (hrtimer_wakeup)
   6411 |          3 |     osso-xterm | schedule_hrtimeout_range (hrtimer_wakeup)
   1790 |          3 |osso-addressboo | queue_delayed_work (delayed_work_timer_fn)
    716 |          3 |           dsme | __enqueue_rt_entity (sched_rt_period_timer)
    770 |          2 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
    770 |          2 |      bme_RX-51 | do_nanosleep (hrtimer_wakeup)
    770 |          2 |      bme_RX-51 | schedule_timeout (process_timeout)
    716 |          2 |           dsme | do_nanosleep (hrtimer_wakeup)
      1 |          2D|  <kernel core> | queue_delayed_work (delayed_work_timer_fn)
    623 |          1 |          mmcqd | queue_delayed_work (delayed_work_timer_fn)
     13 |          1 |        pdflush | ubifs_wbuf_write_nolock (wbuf_timer_callback_nolock)
     13 |          1 |        pdflush | ubifs_wbuf_write_nolock (wbuf_timer_callback_nolock)
   2481 |          1 |        skyhost | sk_reset_timer (tcp_write_timer)
    733 |          1 |        syslogd | hrtimer_start (it_real_fn)
      1 |          1 |  <kernel core> | inet_initpeers (peer_check_expire)
    766 |          1D|<kernel module> | queue_delayed_work (delayed_work_timer_fn)
   2463 |          1 |telepathy-gabbl | sk_reset_timer (tcp_write_timer)
   2463 |          1 |telepathy-gabbl | sk_reset_timer (tcp_write_timer)
   6321 |          1 |       browserd | sk_reset_timer (tcp_write_timer)
    999 |          1 |            mce | schedule_hrtimeout_range (hrtimer_wakeup)
   1820 |          1 |       browserd | futex_wait (hrtimer_wakeup)
   1405 |          1 |hildon-status-m | schedule_hrtimeout_range (hrtimer_wakeup)
   6427 |          1 |       powertop | do_nanosleep (hrtimer_wakeup)

Power domain activity breakdown
Domain  | % of time spent in states
--------+---------+---------+---------+---------+----------
usbhost |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    sgx |OFF:  99%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    per |OFF:  98%|RET:   0%|INA:   0%| ON:   0%| now:(ON)
    dss |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    cam |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
   core |OFF:  96%|RET:   2%|INA:   0%| ON:   1%| now:(ON)
   neon |OFF:  96%|RET:   2%|INA:   0%| ON:   0%| now:(ON)
    mpu |OFF:  96%|RET:   2%|INA:   0%| ON:   0%| now:(ON)
   iva2 |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)

Clock activity breakdown at end of period
Domain  | Active clocks
--------+---------------+---------------+------------------
   core |          SDRC | HSOTGUSB_IDLE |      OMAPCTRL 
        |     MAILBOXES |
   wkup |          GPT1 |       32KSYNC |         GPIO1 
        |          WDT1 |           SR1 |           SR2 
        |
  ckgen |          CORE |          PERI |           96M 
        |           48M |           12M |           54M 
        |      EMU_CORE |
    per |         GPIO2 |         GPIO3 |         GPIO4 
        |         GPIO5 |         GPIO6 |

Total wakeups   343,  11.4/s | IRQ  241,   8.0/s | Timers  102,   3.4/s
HW wakeups       44,   1.5/s |     Real gp_timers expired   73,   2.4/s
Nokia-N900:~#

I am on the latest cssu-thumb, but that should not make any difference. Btw there is very high IRQ count in your powertop outputs, under what conditions did you take those?

The Following 2 Users Say Thank You to freemangordon For This Useful Post:
fw190, tanago

tanago | # 1489 | 2013-08-24, 14:54 | Report

Originally Posted by freemangordon View Post

weird, I can't reproduce your high battery usage, this is my powertop output, device in offline mode:

Code:

...

I am on the latest cssu-thumb, but that should not make any difference. Btw there is very high IRQ count in your powertop outputs, under what conditions did you take those?

bq27200 script is running, and I think thats why. I will upload an output of powertop without battery monitor script running in a few minutes & BTW i was running thumb 24/7/365 too but it shouldnt matter because thumb is just the same Testing packages compiled with thumb support

_________________________

Edit:

Code:

Powertop 1.13.3
Sleeping for 11 seconds before sampling
Collecting data for 30 seconds
Sample interval was 00m 30s 13244us

C#      | Ratio  | Avg/dura | Frequency | Ratio
--------+--------+----------+-----------+--------+
     C0 |   0.5% |          |  1150 MHz |   nan% |
     C1 |   0.0% |          | 
     C2 |  23.7% |  120.5ms | 
     C3 |  10.2% |  146.2ms | 
     C4 |  65.6% | 1514.2ms | 

IRQ#    | Activity   | Type           | Name
--------+------------+----------------+---------------------------
     56 |        244 |           INTC | i2c_omap
     86 |         61 |           INTC | mmc1
     37 |         42 |           INTC | gp
     11 |         38 |           INTC | prcm
     57 |         34 |           INTC | i2c_omap
     67 |         15 |           INTC | ssi_p1_mpu_irq0
     12 |         13 |           INTC | DMA
     71 |         12 |           INTC | ssi_gdd
    311 |          6 |           GPIO | ssi_p1_cawake_gpio

PID#    | Activity   | Name           | Function Entry (Expire)
--------+------------+----------------+---------------------------
      0 |         20 |  <kernel core> | tick_nohz_restart_sched_tick (tick_sched_timer)
     38 |         17D|            awk | cpufreq_governor_dbs (delayed_work_timer_fn)
      0 |          8 |  <kernel core> | hrtimer_start (tick_sched_timer)
    717 |          7 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
    600 |          5 |          mmcqd | queue_delayed_work (delayed_work_timer_fn)
      1 |          3D|  <kernel core> | queue_delayed_work (delayed_work_timer_fn)
    686 |          2 |           dsme | do_nanosleep (hrtimer_wakeup)
    686 |          2 |           dsme | __enqueue_rt_entity (sched_rt_period_timer)
    717 |          2 |      bme_RX-51 | sys_timer_settime (posix_timer_fn)
    717 |          2 |      bme_RX-51 | do_nanosleep (hrtimer_wakeup)
    717 |          2 |      bme_RX-51 | schedule_timeout (process_timeout)
     30 |          1 |          mount | setup_wb_timer (wb_timer_fn)
     14 |          1 |        pdflush | blk_plug_device (blk_unplug_timeout)
      1 |          1 |  <kernel core> | inet_frags_init (inet_frag_secret_rebuild)
      1 |          1 |  <kernel core> | flow_cache_init (flow_cache_new_hashrnd)
    788 |          1 |            mce | schedule_hrtimeout_range (hrtimer_wakeup)
   1785 |          1 |       browserd | futex_wait (hrtimer_wakeup)
   1052 |          1 |          iphbd | schedule_hrtimeout_range (hrtimer_wakeup)
    755 |          1 |           hald | schedule_hrtimeout_range (hrtimer_wakeup)
   1995 |          1 |       powertop | do_nanosleep (hrtimer_wakeup)

Power domain activity breakdown
Domain  | % of time spent in states
--------+---------+---------+---------+---------+----------
usbhost |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    sgx |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
    per |OFF:  73%|RET:  25%|INA:   0%| ON:   0%| now:(ON)
    dss |OFF:   0%|RET:   0%|INA:   0%| ON: 100%| now:(ON)
    cam |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)
   core |OFF:   0%|RET:   0%|INA:   0%| ON: 100%| now:(ON)
   neon |OFF:  65%|RET:  10%|INA:  23%| ON:   0%| now:(ON)
    mpu |OFF:  65%|RET:  10%|INA:  23%| ON:   0%| now:(ON)
   iva2 |OFF: 100%|RET:   0%|INA:   0%| ON:   0%| now:(OFF)

Clock activity breakdown at end of period
Domain  | Active clocks
--------+---------------+---------------+------------------
   core |          SDRC | HSOTGUSB_IDLE |      OMAPCTRL 
        |     MAILBOXES |
   wkup |          GPT1 |       32KSYNC |         GPIO1 
        |          WDT1 |           SR2 |
  ckgen |          CORE |          PERI |           96M 
        |           48M |           12M |           54M 
        |      EMU_CORE |
    dss |      DSS_STBY |      DSS_IDLE 
    per |         GPIO2 |         GPIO3 |         GPIO4 
        |         GPIO5 |         GPIO6 |

Total wakeups   544,  18.1/s | IRQ  465,  15.5/s | Timers   79,   2.6/s
HW wakeups       38,   1.3/s |     Real gp_timers expired   42,   1.4/s

Hmm yeah I still have too much IRQ usage and I wonder why...

Last edited by tanago; 2013-08-24 at 15:03.

The Following User Says Thank You to tanago For This Useful Post:
fw190

freemangordon | # 1490 | 2013-08-24, 15:25 | Report

@tanago: hmm, it is the first time I see ssi_p1_mpu_irq0, ssi_gdd and ssi_p1_cawake_gpio in the IRQ list.

Please, remove your SIM and uSD cards, make sure your device is in offline mode and repeat the test. And make sure the device has settled before running powertop - at least 10-15 minutes after boot.

EDIT:
also, do not run ANY background tasks while running powertop

The Following 3 Users Say Thank You to freemangordon For This Useful Post:
fw190, handaxe, tanago

Page 149 of 189 | Prev | 139 147 148 149 150 151 159 | Next | Last