root@localhost:~/lava-test# lava-test run pwrmgmt
LAVA: Running shell command: 'cd pm-qa && make -k check'
LAVA: (stdout) make[1]: Entering directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/utils'
LAVA: (stderr) make[1]: [uncheck] Error 1 (ignored)
LAVA: (stdout) make[1]: Leaving directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/utils'
LAVA: (stdout) make[1]: Entering directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/cpufreq'
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_01:
LAVA: (stdout) ### test the cpufreq framework is available for frequency
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_01
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_01.0/cpu0: checking 'scaling_available_frequencies' exists...       Ok
LAVA: (stdout) cpufreq_01.1/cpu0: checking 'scaling_cur_freq' exists...                    Ok
LAVA: (stdout) cpufreq_01.2/cpu0: checking 'scaling_setspeed' exists...                    Ok
LAVA: (stdout) cpufreq_01.0/cpu1: checking 'scaling_available_frequencies' exists...       Ok
LAVA: (stdout) cpufreq_01.1/cpu1: checking 'scaling_cur_freq' exists...                    Ok
LAVA: (stdout) cpufreq_01.2/cpu1: checking 'scaling_setspeed' exists...                    Ok
LAVA: (stdout) -------- total = 6
LAVA: (stdout) -------- pass = 6
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_02:
LAVA: (stdout) ### test the cpufreq framework is available for governor
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_02
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_02.0/cpu0: checking 'scaling_available_governors' exists...         Ok
LAVA: (stdout) cpufreq_02.1/cpu0: checking 'scaling_governor' exists...                    Ok
LAVA: (stdout) cpufreq_02.0/cpu1: checking 'scaling_available_governors' exists...         Ok
LAVA: (stdout) cpufreq_02.1/cpu1: checking 'scaling_governor' exists...                    Ok
LAVA: (stdout) -------- total = 4
LAVA: (stdout) -------- pass = 4
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_03:
LAVA: (stdout) ### test the governor change is effective
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_03
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_03.0/cpu0: checking governor change to 'userspace'...               Ok
LAVA: (stdout) cpufreq_03.1/cpu0: checking governor change to 'ondemand'...                Ok
LAVA: (stdout) cpufreq_03.2/cpu0: checking governor change to 'performance'...             Ok
LAVA: (stdout) cpufreq_03.0/cpu1: checking governor change to 'userspace'...               Ok
LAVA: (stdout) cpufreq_03.1/cpu1: checking governor change to 'ondemand'...                Ok
LAVA: (stdout) cpufreq_03.2/cpu1: checking governor change to 'performance'...             Ok
LAVA: (stdout) -------- total = 6
LAVA: (stdout) -------- pass = 6
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_04:
LAVA: (stdout) ### test the change of the frequency is effective in 'userspace' mode
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_04
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_04.0/cpu0: checking setting frequency '1700000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.1/cpu0: checking setting frequency '1600000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.2/cpu0: checking setting frequency '1500000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.3/cpu0: checking setting frequency '1400000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.4/cpu0: checking setting frequency '1300000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.5/cpu0: checking setting frequency '1200000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.6/cpu0: checking setting frequency '1100000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.7/cpu0: checking setting frequency '1000000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.8/cpu0: checking setting frequency '900000 KHz'...               Ok
LAVA: (stdout) cpufreq_04.9/cpu0: checking setting frequency '800000 KHz'...               Ok
LAVA: (stdout) cpufreq_04.10/cpu0: checking setting frequency '700000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.11/cpu0: checking setting frequency '600000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.12/cpu0: checking setting frequency '500000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.13/cpu0: checking setting frequency '400000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.14/cpu0: checking setting frequency '300000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.15/cpu0: checking setting frequency '200000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.0/cpu1: checking setting frequency '1700000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.1/cpu1: checking setting frequency '1600000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.2/cpu1: checking setting frequency '1500000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.3/cpu1: checking setting frequency '1400000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.4/cpu1: checking setting frequency '1300000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.5/cpu1: checking setting frequency '1200000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.6/cpu1: checking setting frequency '1100000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.7/cpu1: checking setting frequency '1000000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.8/cpu1: checking setting frequency '900000 KHz'...               Ok
LAVA: (stdout) cpufreq_04.9/cpu1: checking setting frequency '800000 KHz'...               Ok
LAVA: (stdout) cpufreq_04.10/cpu1: checking setting frequency '700000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.11/cpu1: checking setting frequency '600000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.12/cpu1: checking setting frequency '500000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.13/cpu1: checking setting frequency '400000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.14/cpu1: checking setting frequency '300000 KHz'...              Ok
LAVA: (stdout) cpufreq_04.15/cpu1: checking setting frequency '200000 KHz'...              Ok
LAVA: (stdout) -------- total = 32
LAVA: (stdout) -------- pass = 32
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_05:
LAVA: (stdout) ### test 'ondemand' and 'conservative' trigger correctly the configuration directory
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_05
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_05.0: checking 'ondemand' directory exists...                       Ok
LAVA: (stdout) cpufreq_05.1: conservative not supported...                                 skip
LAVA: (stdout) cpufreq_05.2: checking 'ondemand' directory is not there...                 Ok
LAVA: (stdout) cpufreq_05.3: checking 'conservative' directory is not there...             Ok
LAVA: (stdout) cpufreq_05.4: combine governors not supported...                            skip
LAVA: (stdout) -------- total = 3
LAVA: (stdout) -------- pass = 3
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_06:
LAVA: (stdout) ### test the change of the frequencies affect the performances of a test program
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_06
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_06.0/cpu0: checking deviation for frequency 1700000 KHz...          Ok
LAVA: (stdout) cpufreq_06.1/cpu0: checking deviation for frequency 1600000 KHz...          Ok
LAVA: (stdout) cpufreq_06.2/cpu0: checking deviation for frequency 1500000 KHz...          Ok
LAVA: (stdout) cpufreq_06.3/cpu0: checking deviation for frequency 1400000 KHz...          Ok
LAVA: (stdout) cpufreq_06.4/cpu0: checking deviation for frequency 1300000 KHz...          Ok
LAVA: (stdout) cpufreq_06.5/cpu0: checking deviation for frequency 1200000 KHz...          Ok
LAVA: (stdout) cpufreq_06.6/cpu0: checking deviation for frequency 1100000 KHz...          Ok
LAVA: (stdout) cpufreq_06.7/cpu0: checking deviation for frequency 1000000 KHz...          Ok
LAVA: (stdout) cpufreq_06.8/cpu0: checking deviation for frequency 900000 KHz...           Ok
LAVA: (stdout) cpufreq_06.9/cpu0: checking deviation for frequency 800000 KHz...           Ok
LAVA: (stdout) cpufreq_06.10/cpu0: checking deviation for frequency 700000 KHz...          Ok
LAVA: (stdout) cpufreq_06.11/cpu0: checking deviation for frequency 600000 KHz...          Ok
LAVA: (stdout) cpufreq_06.12/cpu0: checking deviation for frequency 500000 KHz...          Ok
LAVA: (stdout) cpufreq_06.13/cpu0: checking deviation for frequency 400000 KHz...          Ok
LAVA: (stdout) cpufreq_06.14/cpu0: checking deviation for frequency 300000 KHz...          Ok
LAVA: (stdout) cpufreq_06.15/cpu0: checking deviation for frequency 200000 KHz...          Ok
usb 1-3.2.3.3: USB disconnect, device number 29
usb 1-3.2.3.3: new low-speed USB device number 30 using s5p-ehci
usb 1-3.2.3.3: New USB device found, idVendor=093a, idProduct=2510
usb 1-3.2.3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 1-3.2.3.3: Product: USB Optical Mouse
usb 1-3.2.3.3: Manufacturer: PixArt
6input: PixArt USB Optical Mouse as /devices/s5p-ehci/usb1/1-3/1-3.2/1-3.2.3/1-3.2.3.3/1-3.2.3.3:1.0/input/input25
hid-generic 0003:093A:2510.001A: input: USB HID v1.11 Mouse [PixArt USB Optical Mouse] on usb-s5p-ehci-3.2.3.3/input0
LAVA: (stdout) cpufreq_06.0/cpu1: checking deviation for frequency 1700000 KHz...          Ok
LAVA: (stdout) cpufreq_06.1/cpu1: checking deviation for frequency 1600000 KHz...          Ok
LAVA: (stdout) cpufreq_06.2/cpu1: checking deviation for frequency 1500000 KHz...          Ok
LAVA: (stdout) cpufreq_06.3/cpu1: checking deviation for frequency 1400000 KHz...          Ok
LAVA: (stdout) cpufreq_06.4/cpu1: checking deviation for frequency 1300000 KHz...          Ok
LAVA: (stdout) cpufreq_06.5/cpu1: checking deviation for frequency 1200000 KHz...          Ok
LAVA: (stdout) cpufreq_06.6/cpu1: checking deviation for frequency 1100000 KHz...          Ok
LAVA: (stdout) cpufreq_06.7/cpu1: checking deviation for frequency 1000000 KHz...          Ok
LAVA: (stdout) cpufreq_06.8/cpu1: checking deviation for frequency 900000 KHz...           Ok
LAVA: (stdout) cpufreq_06.9/cpu1: checking deviation for frequency 800000 KHz...           Ok
LAVA: (stdout) cpufreq_06.10/cpu1: checking deviation for frequency 700000 KHz...          Ok
LAVA: (stdout) cpufreq_06.11/cpu1: checking deviation for frequency 600000 KHz...          Ok
LAVA: (stdout) cpufreq_06.12/cpu1: checking deviation for frequency 500000 KHz...          Ok
LAVA: (stdout) cpufreq_06.13/cpu1: checking deviation for frequency 400000 KHz...          Ok
LAVA: (stdout) cpufreq_06.14/cpu1: checking deviation for frequency 300000 KHz...          Ok
LAVA: (stdout) cpufreq_06.15/cpu1: checking deviation for frequency 200000 KHz...          Ok
LAVA: (stdout) -------- total = 32
LAVA: (stdout) -------- pass = 32
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_07:
LAVA: (stdout) ### test the load of the cpu affects the frequency with 'ondemand'
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_07
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_07.0/cpu0: checking 'ondemand' increase frequency on load...        Ok
LAVA: (stdout) cpufreq_07.1/cpu0: checking 'ondemand' decrease frequency on idle...        Ok
LAVA: (stdout) cpufreq_07.0/cpu1: checking 'ondemand' increase frequency on load...        Ok
LAVA: (stdout) cpufreq_07.1/cpu1: checking 'ondemand' decrease frequency on idle...        Ok
LAVA: (stdout) -------- total = 4
LAVA: (stdout) -------- pass = 4
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_08:
LAVA: (stdout) ### test the load of the cpu does not affect the frequency with 'userspace'
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_08
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_08.0/cpu0: checking 'userspace' 1700000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.1/cpu0: checking 'userspace' 1600000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.2/cpu0: checking 'userspace' 1500000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.3/cpu0: checking 'userspace' 1400000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.4/cpu0: checking 'userspace' 1300000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.5/cpu0: checking 'userspace' 1200000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.6/cpu0: checking 'userspace' 1100000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.7/cpu0: checking 'userspace' 1000000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.8/cpu0: checking 'userspace' 900000 KHz is fixed...              Ok
LAVA: (stdout) cpufreq_08.9/cpu0: checking 'userspace' 800000 KHz is fixed...              Ok
LAVA: (stdout) cpufreq_08.10/cpu0: checking 'userspace' 700000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.11/cpu0: checking 'userspace' 600000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.12/cpu0: checking 'userspace' 500000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.13/cpu0: checking 'userspace' 400000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.14/cpu0: checking 'userspace' 300000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.15/cpu0: checking 'userspace' 200000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.0/cpu1: checking 'userspace' 1700000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.1/cpu1: checking 'userspace' 1600000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.2/cpu1: checking 'userspace' 1500000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.3/cpu1: checking 'userspace' 1400000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.4/cpu1: checking 'userspace' 1300000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.5/cpu1: checking 'userspace' 1200000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.6/cpu1: checking 'userspace' 1100000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.7/cpu1: checking 'userspace' 1000000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.8/cpu1: checking 'userspace' 900000 KHz is fixed...              Ok
LAVA: (stdout) cpufreq_08.9/cpu1: checking 'userspace' 800000 KHz is fixed...              Ok
LAVA: (stdout) cpufreq_08.10/cpu1: checking 'userspace' 700000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.11/cpu1: checking 'userspace' 600000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.12/cpu1: checking 'userspace' 500000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.13/cpu1: checking 'userspace' 400000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.14/cpu1: checking 'userspace' 300000 KHz is fixed...             Ok
LAVA: (stdout) cpufreq_08.15/cpu1: checking 'userspace' 200000 KHz is fixed...             Ok
LAVA: (stdout) -------- total = 32
LAVA: (stdout) -------- pass = 32
LAVA: (stdout) ###
LAVA: (stdout) ### cpufreq_09:
LAVA: (stdout) ### test the load of the cpu does not affect the frequency with 'powersave'
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpufreq_09
LAVA: (stdout) ###
LAVA: (stdout) cpufreq_09.0: powersave not supported...                                    skip
LAVA: (stdout) make[1]: Leaving directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/cpufreq'
LAVA: (stdout) make[1]: Entering directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/cpuhotplug'
LAVA: (stdout) ###
LAVA: (stdout) ### 1_sanity_check:
LAVA: (stdout) ### ensure all the cpus are online before the tests
LAVA: (stdout) ### ###
LAVA: (stdout) 1_sanity_check.0: checking all cpu are online...                            Ok
LAVA: (stdout) -------- total = 1
LAVA: (stdout) -------- pass = 1
LAVA: (stdout) ###
LAVA: (stdout) ### cpuhotplug_01:
LAVA: (stdout) ### test the sysfs files are present
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpuhotplug_01
LAVA: (stdout) ###
LAVA: (stdout) cpuhotplug_01.0: checking 'online' exists...                                Ok
LAVA: (stdout) cpuhotplug_01.1: checking 'offline' exists...                               Ok
LAVA: (stdout) cpuhotplug_01.2: checking 'possible' exists...                              Ok
LAVA: (stdout) cpuhotplug_01.3: checking 'present' exists...                               Ok
LAVA: (stdout) cpuhotplug_01.0/cpu0: checking 'online' exists...                           Ok
LAVA: (stdout) cpuhotplug_01.0/cpu1: checking 'online' exists...                           Ok
LAVA: (stdout) -------- total = 6
LAVA: (stdout) -------- pass = 6
LAVA: (stdout) ###
LAVA: (stdout) ### cpuhotplug_02:
LAVA: (stdout) ### test the cpu state is reflected in sysfs
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpuhotplug_02
LAVA: (stdout) ###
4IRQ153 no longer affine to CPU1
4IRQ340 no longer affine to CPU1
5CPU1: shutdown
3CPU1: failed to boot: -38
[ 1468.610000] CPU1: failed to boot: -38
LAVA: (stdout) cpuhotplug_02.0/cpu1: checking cpu is offline...                            Ok
LAVA: (stdout) cpuhotplug_02.1/cpu1: checking cpu is online...                             Err
LAVA: (stdout) -------- total = 2
LAVA: (stdout) -------- pass = 1
LAVA: (stdout) -------- fail = 1
LAVA: (stdout) ###
LAVA: (stdout) ### cpuhotplug_03:
LAVA: (stdout) ### test the affinity does not work on an offline cpu
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpuhotplug_03
LAVA: (stdout) ###
3CPU1: failed to boot: -38
[ 1469.670000] CPU1: failed to boot: -38
LAVA: (stdout) cpuhotplug_03.0/cpu1: checking setting affinity on cpu fails...             Ok
LAVA: (stdout) -------- total = 1
LAVA: (stdout) -------- pass = 1
LAVA: (stdout) ###
LAVA: (stdout) ### cpuhotplug_04:
LAVA: (stdout) ### test task is migrated with task affinity
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpuhotplug_04
LAVA: (stdout) ###
LAVA: (stdout) cpuhotplug_04.0/cpu1: checking affinity is set...                           Err
LAVA: (stdout) cpuhotplug_04.1/cpu1: checking offlining a cpu with affinity succeed...     Err
LAVA: (stdout) cpuhotplug_04.2/cpu1: checking affinity changed...                          Ok
3CPU1: failed to boot: -38
[ 1472.850000] CPU1: failed to boot: -38
LAVA: (stdout) -------- total = 3
LAVA: (stdout) -------- pass = 1
LAVA: (stdout) -------- fail = 2
LAVA: (stdout) ###
LAVA: (stdout) ### cpuhotplug_05:
LAVA: (stdout) ### test cpus are reflected on /proc/cpuinfo correctly
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpuhotplug_05
LAVA: (stdout) ###
3CPU1: failed to boot: -38
[ 1473.890000] CPU1: failed to boot: -38
3CPU1: failed to boot: -38
[ 1474.920000] CPU1: failed to boot: -38
LAVA: (stdout) cpuhotplug_05.0/cpu1: checking offline processor not found in cpuinfo...    Ok
LAVA: (stdout) -------- total = 1
LAVA: (stdout) -------- pass = 1
LAVA: (stdout) ###
LAVA: (stdout) ### cpuhotplug_06:
LAVA: (stdout) ### test interrupts show the right configuration in /proc/interrupts
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpuhotplug_06
LAVA: (stdout) ###
LAVA: (stdout) cpuhotplug_06.0/cpu1: checking offline processor not found in interrupts... Ok
LAVA: (stdout) -------- total = 1
LAVA: (stdout) -------- pass = 1
LAVA: (stdout) ###
LAVA: (stdout) ### cpuhotplug_07:
LAVA: (stdout) ### test userspace notification
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpuhotplug_07
LAVA: (stdout) ###
3CPU1: failed to boot: -38
[ 1475.970000] CPU1: failed to boot: -38
LAVA: (stdout) cpuhotplug_07.0/cpu1: checking offline event was received...                Err
LAVA: (stdout) cpuhotplug_07.1/cpu1: checking online event was received...                 Err
LAVA: (stdout) -------- total = 2
LAVA: (stdout) -------- pass = 0
LAVA: (stdout) -------- fail = 2
LAVA: (stdout) ###
LAVA: (stdout) ### cpuhotplug_08:
LAVA: (stdout) ### test userspace notification
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cpuhotplug_08
LAVA: (stdout) ###
3CPU1: failed to boot: -38
[ 1478.190000] CPU1: failed to boot: -38
6thermal polling set for duration=0 msec
6thermal polling set for duration=0 msec
6thermal polling set for duration=0 msec
LAVA: (stdout) cpuhotplug_08.0: checking cpu1 is offline...                                Err
LAVA: (stderr) ./thermal_sanity.sh: line 34: test_status_show: command not found
LAVA: (stdout) cpuhotplug_08.1: checking cpu1 is online...                                 Err
LAVA: (stdout) -------- total = 2
LAVA: (stdout) -------- pass = 0
LAVA: (stdout) -------- fail = 2
LAVA: (stdout) ###
LAVA: (stdout) ### z_sanity_check:
LAVA: (stdout) ### ensure all the cpus are online when the tests are finished
LAVA: (stdout) ### ###
LAVA: (stdout) z_sanity_check.0: checking all cpu are back online...                       Err
LAVA: (stdout) -------- total = 1
LAVA: (stdout) -------- pass = 0
LAVA: (stdout) -------- fail = 1
LAVA: (stdout) make[1]: Leaving directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/cpuhotplug'
LAVA: (stdout) make[1]: Entering directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/cpuidle'
LAVA: (stdout) cpuidle is not enabled. Skipping all cpudile tests...
LAVA: (stdout) make[1]: Leaving directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/cpuidle'
LAVA: (stdout) make[1]: Entering directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/thermal'
LAVA: (stdout) ###
LAVA: (stdout) ### thermal_01:
LAVA: (stdout) ### test/verify the thermal zone files are present in the sysfs and check the validity of the mode field, bindings and trip tes
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#thermal_01
LAVA: (stdout) ###
LAVA: (stdout) thermal_01.0: checking 'mode' exists...                                     Ok
LAVA: (stdout) thermal_01.1: checking 'temp' exists...                                     Ok
LAVA: (stdout) thermal_01.2: checking 'type' exists...                                     Ok
LAVA: (stdout) thermal_01.3: checking 'uevent' exists...                                   Ok
LAVA: (stdout) thermal_01.4: checking 'thermal_zone0'/'temp' ='59000'...                   pass
LAVA: (stdout) thermal_01.0: checking thermal_zone0 cur_mode=enabled...                    Ok
LAVA: (stdout) thermal_01.1: checking thermal_zone0 cur_mode=disabled...                   Ok
LAVA: (stdout) thermal_01.2: checking 'trip_point_0_temp' exists...                        Ok
LAVA: (stdout) thermal_01.3: checking 'trip_point_0_type' exists...                        Ok
LAVA: (stdout) thermal_01.4: checking 'thermal_zone0'/'trip_point_0_temp' ='85000'...      pass
LAVA: (stdout) thermal_01.5: checking 'trip_point_1_temp' exists...                        Ok
LAVA: (stdout) thermal_01.6: checking 'trip_point_1_type' exists...                        Ok
LAVA: (stdout) thermal_01.7: checking 'thermal_zone0'/'trip_point_1_temp' ='103000'...     pass
LAVA: (stdout) thermal_01.8: checking 'trip_point_2_temp' exists...                        Ok
LAVA: (stdout) thermal_01.9: checking 'trip_point_2_type' exists...                        Ok
LAVA: (stdout) thermal_01.10: checking 'thermal_zone0'/'trip_point_2_temp' ='110000'...    pass
LAVA: (stdout) -------- total = 12
LAVA: (stdout) -------- pass = 12
LAVA: (stdout) ###
LAVA: (stdout) ### thermal_02:
LAVA: (stdout) ### test/verify the cooling device files are present in the sysfs
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#thermal_02
LAVA: (stdout) ###
LAVA: (stdout) thermal_02.0: checking 'cur_state' exists...                                Ok
LAVA: (stdout) thermal_02.1: checking 'max_state' exists...                                Ok
LAVA: (stdout) thermal_02.2: checking 'type' exists...                                     Ok
LAVA: (stdout) thermal_02.3: checking 'uevent' exists...                                   Ok
LAVA: (stdout) thermal_02.0: checking cooling_device0 cur_state=0...                       Ok
LAVA: (stdout) thermal_02.1: checking cooling_device0 cur_state=1...                       Ok
LAVA: (stdout) thermal_02.2: checking cooling_device0 cur_state=2...                       Ok
LAVA: (stdout) thermal_02.3: checking cooling_device0 cur_state=3...                       Ok
LAVA: (stdout) thermal_02.4: checking cooling_device0 cur_state=4...                       Ok
LAVA: (stdout) thermal_02.5: checking cooling_device0 cur_state=5...                       Ok
LAVA: (stdout) thermal_02.6: checking cooling_device0 cur_state=6...                       Ok
LAVA: (stdout) thermal_02.7: checking cooling_device0 cur_state=7...                       Ok
LAVA: (stdout) thermal_02.8: checking cooling_device0 cur_state=8...                       Ok
LAVA: (stdout) thermal_02.9: checking cooling_device0 cur_state=9...                       Ok
LAVA: (stdout) thermal_02.10: checking cooling_device0 cur_state=10...                     Ok
LAVA: (stdout) thermal_02.11: checking cooling_device0 cur_state=11...                     Ok
LAVA: (stdout) thermal_02.12: checking cooling_device0 cur_state=12...                     Ok
LAVA: (stdout) thermal_02.13: checking cooling_device0 cur_state=13...                     Ok
LAVA: (stdout) thermal_02.14: checking cooling_device0 cur_state=14...                     Ok
LAVA: (stdout) thermal_02.15: checking cooling_device0 cur_state=15...                     Ok
LAVA: (stdout) -------- total = 20
LAVA: (stdout) -------- pass = 20
LAVA: (stdout) ###
LAVA: (stdout) ### thermal_03:
LAVA: (stdout) ### test/verify that temperature is increasing/decreasing as the load is increased/decreased
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#thermal_03
LAVA: (stdout) ###
LAVA: (stdout) thermal_03.0: checking start cpu heat binary...                             Ok
LAVA: (stdout) thermal_03.1: checking temperature variation with load...                   Ok
LAVA: (stdout) -------- total = 2
LAVA: (stdout) -------- pass = 2
LAVA: (stdout) ###
LAVA: (stdout) ### thermal_04:
LAVA: (stdout) ### test/verify the cooling device are lowering the temperature down
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#therma6thermal polling set for duration=0 msec
l_04
LAVA: (stdout) ###
usb 1-3.2.3.3: USB disconnect, device number 30
usb 1-3.2.3.3: new low-speed USB device number 31 using s5p-ehci
usb 1-3.2.3.3: New USB device found, idVendor=093a, idProduct=2510
usb 1-3.2.3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 1-3.2.3.3: Product: USB Optical Mouse
usb 1-3.2.3.3: Manufacturer: PixArt
6input: PixArt USB Optical Mouse as /devices/s5p-ehci/usb1/1-3/1-3.2/1-3.2.3/1-3.2.3.3/1-3.2.3.3:1.0/input/input26
hid-generic 0003:093A:2510.001B: input: USB HID v1.11 Mouse [PixArt USB Optical Mouse] on usb-s5p-ehci-3.2.3.3/input0
LAVA: (stdout) thermal_04.0: checking cooling_device0:state=1 effective cool=1000 ...      Ok
LAVA: (stdout) thermal_04.1: checking cooling_device0:state=2 effective cool=3000 ...      Ok
LAVA: (stdout) thermal_04.2: checking cooling_device0:state=3 effective cool=5000 ...      Ok
LAVA: (stdout) thermal_04.3: checking cooling_device0:state=4 effective cool=6000 ...      Ok
LAVA: (stdout) thermal_04.4: checking cooling_device0:state=5 effective cool=7000 ...      Ok
LAVA: (stdout) thermal_04.5: checking cooling_device0:state=6 effective cool=8000 ...      Ok
usb 1-3.2.3.3: USB disconnect, device number 31
usb 1-3.2.3.3: new low-speed USB device number 32 using s5p-ehci
usb 1-3.2.3.3: New USB device found, idVendor=093a, idProduct=2510
usb 1-3.2.3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 1-3.2.3.3: Product: USB Optical Mouse
usb 1-3.2.3.3: Manufacturer: PixArt
6input: PixArt USB Optical Mouse as /devices/s5p-ehci/usb1/1-3/1-3.2/1-3.2.3/1-3.2.3.3/1-3.2.3.3:1.0/input/input27
hid-generic 0003:093A:2510.001C: input: USB HID v1.11 Mouse [PixArt USB Optical Mouse] on usb-s5p-ehci-3.2.3.3/input0
LAVA: (stdout) thermal_04.6: checking cooling_device0:state=7 effective cool=9000 ...      Ok
LAVA: (stdout) thermal_04.7: checking cooling_device0:state=8 effective cool=9000 ...      Ok
LAVA: (stdout) thermal_04.8: checking cooling_device0:state=9 effective cool=10000 ...     Ok
LAVA: (stdout) thermal_04.9: checking cooling_device0:state=10 effective cool=11000 ...    Ok
LAVA: (stdout) thermal_04.10: checking cooling_device0:state=11 effective cool=11000 ...   Ok
LAVA: (stdout) thermal_04.11: checking cooling_device0:state=12 effective cool=12000 ...   Ok
usb 1-3.2.3.3: USB disconnect, device number 32
usb 1-3.2.3.3: new low-speed USB device number 33 using s5p-ehci
usb 1-3.2.3.3: New USB device found, idVendor=093a, idProduct=2510
usb 1-3.2.3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 1-3.2.3.3: Product: USB Optical Mouse
usb 1-3.2.3.3: Manufacturer: PixArt
6input: PixArt USB Optical Mouse as /devices/s5p-ehci/usb1/1-3/1-3.2/1-3.2.3/1-3.2.3.3/1-3.2.3.3:1.0/input/input28
hid-generic 0003:093A:2510.001D: input: USB HID v1.11 Mouse [PixArt USB Optical Mouse] on usb-s5p-ehci-3.2.3.3/input0
LAVA: (stdout) thermal_04.12: checking cooling_device0:state=13 effective cool=13000 ...   Ok
LAVA: (stdout) thermal_04.13: checking cooling_device0:state=14 effective cool=13000 ...   Ok
LAVA: (stdout) thermal_04.14: checking cooling_device0:state=15 effective cool=14000 ...   Ok
6thermal polling set for duration=0 msec
LAVA: (stdout) -------- total = 15
LAVA: (stdout) -------- pass = 15
LAVA: (stdout) ###
LAVA: (stdout) ### thermal_05:
LAVA: (stdout) ### test/verify the cpufreq cooling device are clipping the frequencies
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#thermal_05
LAVA: (stdout) ###
LAVA: (stdout) thermal-cpufreq-0
6thermal polling set for duration=0 msec
LAVA: (stdout) thermal_05.0: checking cdev=cooling_device0 state=1...                      Ok
LAVA: (stdout) thermal_05.1: checking cdev=cooling_device0 state=2...                      Ok
LAVA: (stdout) thermal_05.2: checking cdev=cooling_device0 state=3...                      Ok
LAVA: (stdout) thermal_05.3: checking cdev=cooling_device0 state=4...                      Ok
LAVA: (stdout) thermal_05.4: checking cdev=cooling_device0 state=5...                      Ok
LAVA: (stdout) thermal_05.5: checking cdev=cooling_device0 state=6...                      Ok
LAVA: (stdout) thermal_05.6: checking cdev=cooling_device0 state=7...                      Ok
LAVA: (stdout) thermal_05.7: checking cdev=cooling_device0 state=8...                      Ok
LAVA: (stdout) thermal_05.8: checking cdev=cooling_device0 state=9...                      Ok
LAVA: (stdout) thermal_05.9: checking cdev=cooling_device0 state=10...                     Ok
LAVA: (stdout) thermal_05.10: checking cdev=cooling_device0 state=11...                    Ok
LAVA: (stdout) thermal_05.11: checking cdev=cooling_device0 state=12...                    Ok
LAVA: (stdout) thermal_05.12: checking cdev=cooling_device0 state=13...                    Ok
LAVA: (stdout) thermal_05.13: checking cdev=cooling_device0 state=14...                    Ok
LAVA: (stdout) thermal_05.14: checking cdev=cooling_device0 state=15...                    Ok
6thermal polling set for duration=0 msec
LAVA: (stdout) -------- total = 15
LAVA: (stdout) -------- pass = 15
LAVA: (stdout) ###
LAVA: (stdout) ### thermal_06:
LAVA: (stdout) ### test/verify that different trip points are crossed when load is maximum
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#thermal_06
LAVA: (stdout) ###
LAVA: (stdout) thermal_06.0: test of trip points being crossed...                          skip
LAVA: (stdout) make[1]: Leaving directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/thermal'
LAVA: (stdout) make[1]: Entering directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/cputopology'
LAVA: (stdout) ###
LAVA: (stdout) ### cputopology_01:
LAVA: (stdout) ### test the topology is implemented in the kernel
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cputopology_01
LAVA: (stdout) ###
LAVA: (stdout) cputopology_01.0/cpu0: checking topology is enabled...                      Ok
LAVA: (stdout) cputopology_01.0/cpu1: checking topology is enabled...                      Ok
LAVA: (stdout) -------- total = 2
LAVA: (stdout) -------- pass = 2
LAVA: (stdout) ###
LAVA: (stdout) ### cputopology_02:
LAVA: (stdout) ### test the topology files are present
LAVA: (stdout) ### https://wiki.linaro.org/WorkingGroups/PowerManagement/Doc/QA/Scripts#cputopology_02
LAVA: (stdout) ###
LAVA: (stdout) cputopology_02.0/cpu0: checking 'core_id' exists...                         Ok
LAVA: (stdout) cputopology_02.1/cpu0: checking 'core_siblings' exists...                   Ok
LAVA: (stdout) cputopology_02.2/cpu0: checking 'core_siblings_list' exists...              Ok
LAVA: (stdout) cputopology_02.3/cpu0: checking 'physical_package_id' exists...             Ok
LAVA: (stdout) cputopology_02.4/cpu0: checking 'thread_siblings' exists...                 Ok
LAVA: (stdout) cputopology_02.5/cpu0: checking 'thread_siblings_list' exists...            Ok
LAVA: (stdout) cputopology_02.0/cpu1: checking 'core_id' exists...                         Err
LAVA: (stdout) -------- total = 7
LAVA: (stdout) -------- pass = 6
LAVA: (stdout) -------- fail = 1
LAVA: (stdout) make[1]: Leaving directory `/root/.local/share/lava_test/installed-tests/pwrmgmt/pm-qa/cputopology'
LAVA: run complete, result_id is 'pwrmgmt.2013-05-22T11:02:43Z'