2014-08-01 12:33:06 PM DEBUG: [ACTION-B] Single node test! 2014-08-01 12:33:06 PM INFO: [ACTION-B] deploy_linaro_image is started with {u'customize': {u'file:///var/lib/lava/dispatcher/tmp/LEG/grub_v3.cfg': [u'boot:/grub/grub.cfg'], u'file:///var/lib/lava/dispatcher/tmp/LEG/grub_leg_armv8.efi-multiboot_dev': [u'boot:/EFI/BOOT/grub_v8.efi'], u'boot:/Image': [u'delete'], u'boot:/img.axf': [u'delete'], u'file:///var/lib/lava/dispatcher/tmp/LEG/xen_dom0_Image': [u'boot:/Image'], u'file:///var/lib/lava/dispatcher/tmp/LEG/initramfs_leg_armv8.cpio.gz': [u'boot:/'], u'file:///var/lib/lava/dispatcher/tmp/LEG/fvp_fip.bin': [u'boot:/'], u'file:///var/lib/lava/dispatcher/tmp/LEG/xen_startup.nsh': [u'boot:/EFI/BOOT/startup.nsh'], u'file:///var/lib/lava/dispatcher/tmp/uefi-vars-blank.fd': [u'boot:/uefi-vars.fd'], u'boot:/img-foundation.axf': [u'delete'], u'file:///var/lib/lava/dispatcher/tmp/LEG/fvp_bl1.bin': [u'boot:/'], u'boot:/fvp': [u'delete'], u'boot:/rtsm': [u'delete'], u'file:///var/lib/lava/dispatcher/tmp/LEG/xenpolicy.24': [u'boot:/xsm'], u'file:///var/lib/lava/dispatcher/tmp/LEG/xen': [u'boot:/xen']}, u'image': u'file:///home/tekkamanninja/images/vexpress64-leg-sd.img.gz', u'bootloadertype': u'uefi'} 2014-08-01 12:33:06 PM DEBUG: About to download file:///home/tekkamanninja/images/vexpress64-leg-sd.img.gz to the host 2014-08-01 12:33:06 PM INFO: Downloading image: file:///home/tekkamanninja/images/vexpress64-leg-sd.img.gz 2014-08-01 12:33:19 PM INFO: md5sum of downloaded content: 83fef9258f4e17343d7cf8a5662dbf97 2014-08-01 12:33:19 PM DEBUG: sha256sum of downloaded content: 1f7e60f938698d275d82b2c9890e2f0f2701e2fc43326622e60dcd943ffbce9e 2014-08-01 12:33:31 PM DEBUG: Executing on host : 'u'sudo mount -o loop,offset=32256 /linaro/images/tmp/tmpvrY12w/vexpress64-leg-sd.img /tmp/tmp0UgXxA'' 2014-08-01 12:33:31 PM DEBUG: Executing on host : 'u'sudo mount -o loop,offset=71303168 /linaro/images/tmp/tmpvrY12w/vexpress64-leg-sd.img /tmp/tmpPJs3mO'' 2014-08-01 12:33:31 PM DEBUG: Do customizing image with {'image': [{'src': u'boot:/Image', 'des': []}, {'src': u'boot:/img.axf', 'des': []}, {'src': u'boot:/img-foundation.axf', 'des': []}, {'src': u'boot:/fvp', 'des': []}, {'src': u'boot:/rtsm', 'des': []}], 'remote': [{'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/grub_v3.cfg', 'des': [u'boot:/grub/grub.cfg']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/grub_leg_armv8.efi-multiboot_dev', 'des': [u'boot:/EFI/BOOT/grub_v8.efi']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/xen_dom0_Image', 'des': [u'boot:/Image']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/initramfs_leg_armv8.cpio.gz', 'des': [u'boot:/']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/fvp_fip.bin', 'des': [u'boot:/']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/xen_startup.nsh', 'des': [u'boot:/EFI/BOOT/startup.nsh']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/uefi-vars-blank.fd', 'des': [u'boot:/uefi-vars.fd']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/fvp_bl1.bin', 'des': [u'boot:/']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/xenpolicy.24', 'des': [u'boot:/xsm']}, {'src': u'file:///var/lib/lava/dispatcher/tmp/LEG/xen', 'des': [u'boot:/xen']}], 'delete': [u'boot:/Image', u'boot:/img.axf', u'boot:/img-foundation.axf', u'boot:/fvp', u'boot:/rtsm']} 2014-08-01 12:33:31 PM DEBUG: Copying file from #1:/Image(/tmp/tmp0UgXxA//Image) to /linaro/images/tmp/tmpl_595F/Image! 2014-08-01 12:33:31 PM DEBUG: Copying file from #1:/img.axf(/tmp/tmp0UgXxA//img.axf) to /linaro/images/tmp/tmpNbObed/img.axf! 2014-08-01 12:33:31 PM DEBUG: Copying file from #1:/img-foundation.axf(/tmp/tmp0UgXxA//img-foundation.axf) to /linaro/images/tmp/tmpzaqL3N/img-foundation.axf! 2014-08-01 12:33:31 PM DEBUG: Copying dir from #1:/fvp(/tmp/tmp0UgXxA//fvp) to /linaro/images/tmp/tmpwU2cp5/fvp! 2014-08-01 12:33:31 PM DEBUG: Copying dir from #1:/rtsm(/tmp/tmp0UgXxA//rtsm) to /linaro/images/tmp/tmpM2gs4N/rtsm! 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/grub_v3.cfg to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/grub_v3.cfg 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: ab6e5628162750f02d792d856a348a3a 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: b4e2175548d3beb5aff94be513e50c31a959145fbbb8cf668fc305ad3a60c863 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/grub_leg_armv8.efi-multiboot_dev to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/grub_leg_armv8.efi-multiboot_dev 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: d8190e3b12e8ca944fc2b2d72f99386f 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: d8f5d940e1519512fa16fa2141725ea431e519a911bde3462958b98b1c9fd6a9 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/xen_dom0_Image to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/xen_dom0_Image 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: b869b7a3c9bf546d636f373ab9c12997 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: 5ba84f8dfaf0e28a323bd0831d0cc3f49e8a9a63261160817f8281eae79abb34 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/initramfs_leg_armv8.cpio.gz to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/initramfs_leg_armv8.cpio.gz 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: c04e96b1937a50d402819afd71025525 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: ea2b8ac859cd7f29306fb7e489fdc26cffcb2516f2c2ae953923a305f9b0d88f 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/fvp_fip.bin to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/fvp_fip.bin 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: 0fca40665f0d974c04f3455aace1d221 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: 3e683844136520407fbe9dd7432c49556873c60d9754356e644bb462e56aa369 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/xen_startup.nsh to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/xen_startup.nsh 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: dfd51db723cff8b74c0eb711678209b9 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: 898aa7dd921b67ba1a1c2eb2b0ca4489de5dccd030646b916abe440530b6e2ba 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/uefi-vars-blank.fd to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/uefi-vars-blank.fd 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: d41d8cd98f00b204e9800998ecf8427e 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/fvp_bl1.bin to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/fvp_bl1.bin 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: f93d2a92dacca6caeb9f6001c03bdf1c 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: a4a9d40b81d9ffc6a0f56817a5591e68f6ce48a0ff5faf7e2e4f647dc7d9f4f3 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/xenpolicy.24 to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/xenpolicy.24 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: 0530d715d559490d068826d68bd908ae 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: 129a6bdf02d80dfac666afbf2b945e3fdaa6b145697fd25762d4ecdb6fd8491c 2014-08-01 12:33:31 PM DEBUG: About to download file:///var/lib/lava/dispatcher/tmp/LEG/xen to the host 2014-08-01 12:33:31 PM INFO: Downloading image: file:///var/lib/lava/dispatcher/tmp/LEG/xen 2014-08-01 12:33:31 PM INFO: md5sum of downloaded content: f53c62120fb56b5e4bbd10e8e8cf80ed 2014-08-01 12:33:31 PM DEBUG: sha256sum of downloaded content: 9c42823f12e7dbe8d466f5077715327c88d1eb88afa72423a55a014235657454 2014-08-01 12:33:31 PM DEBUG: Removing file(/tmp/tmp0UgXxA//Image) /Image from #1 partition of image! 2014-08-01 12:33:31 PM DEBUG: Removing file(/tmp/tmp0UgXxA//img.axf) /img.axf from #1 partition of image! 2014-08-01 12:33:31 PM DEBUG: Removing file(/tmp/tmp0UgXxA//img-foundation.axf) /img-foundation.axf from #1 partition of image! 2014-08-01 12:33:31 PM DEBUG: Removing dir(/tmp/tmp0UgXxA//fvp) /fvp from #1 partition of image! 2014-08-01 12:33:31 PM DEBUG: Removing dir(/tmp/tmp0UgXxA//rtsm) /rtsm from #1 partition of image! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//grub/grub.cfg to #1:/grub/grub.cfg(/linaro/images/tmp/tmpyfRF0V/grub_v3.cfg)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//EFI/BOOT/grub_v8.efi to #1:/EFI/BOOT/grub_v8.efi(/linaro/images/tmp/tmp1tVoXI/grub_leg_armv8.efi-multiboot_dev)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//Image to #1:/Image(/linaro/images/tmp/tmpCmcepJ/.xen_dom0_Image)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//initramfs_leg_armv8.cpio to #1:/(/linaro/images/tmp/tmp0FHCv3/initramfs_leg_armv8.cpio)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//fvp_fip.bin to #1:/(/linaro/images/tmp/tmpjPNGTP/fvp_fip.bin)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//EFI/BOOT/startup.nsh to #1:/EFI/BOOT/startup.nsh(/linaro/images/tmp/tmpK23skI/xen_startup.nsh)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//uefi-vars.fd to #1:/uefi-vars.fd(/linaro/images/tmp/tmpKvKS0N/uefi-vars-blank.fd)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//fvp_bl1.bin to #1:/(/linaro/images/tmp/tmpTikXqu/fvp_bl1.bin)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//xsm to #1:/xsm(/linaro/images/tmp/tmpg_Yc3q/xenpolicy.24)! 2014-08-01 12:33:31 PM DEBUG: Copying file from /tmp/tmp0UgXxA//xen to #1:/xen(/linaro/images/tmp/tmpnTLg_w/.xen)! 2014-08-01 12:33:31 PM DEBUG: Executing on host : ''sync'' 2014-08-01 12:33:32 PM DEBUG: Executing on host : ''sudo umount /tmp/tmpPJs3mO'' 2014-08-01 12:33:32 PM DEBUG: Executing on host : ''rm -rf /tmp/tmpPJs3mO'' 2014-08-01 12:33:32 PM DEBUG: Executing on host : ''sync'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : ''sudo umount /tmp/tmp0UgXxA'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : ''rm -rf /tmp/tmp0UgXxA'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : 'u'sudo mount -o loop,offset=32256 /linaro/images/tmp/tmpvrY12w/vexpress64-leg-sd.img /tmp/tmphivGsI'' 2014-08-01 12:33:33 PM INFO: Loading file: /tmp/tmphivGsI/fvp_fip.bin 2014-08-01 12:33:33 PM INFO: Loading file: /tmp/tmphivGsI/Image 2014-08-01 12:33:33 PM INFO: Loading file: /tmp/tmphivGsI/fvp-base-gicv2-psci.dtb 2014-08-01 12:33:33 PM INFO: Loading file: /tmp/tmphivGsI/fvp_bl1.bin 2014-08-01 12:33:33 PM DEBUG: Executing on host : ''sync'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : ''sudo umount /tmp/tmphivGsI'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : ''rm -rf /tmp/tmphivGsI'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : 'u'sudo mount -o loop,offset=71303168 /linaro/images/tmp/tmpvrY12w/vexpress64-leg-sd.img /tmp/tmpRCL1mM'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : ''sync'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : ''sudo umount /tmp/tmpRCL1mM'' 2014-08-01 12:33:33 PM DEBUG: Executing on host : ''rm -rf /tmp/tmpRCL1mM'' 2014-08-01 12:33:34 PM DEBUG: Executing on host : 'u'sudo mount -o loop,offset=71303168 /linaro/images/tmp/tmpvrY12w/vexpress64-leg-sd.img /tmp/tmp9VMILJ'' 2014-08-01 12:33:34 PM DEBUG: Executing on host : ''sync'' 2014-08-01 12:33:34 PM DEBUG: Executing on host : ''sudo umount /tmp/tmp9VMILJ'' 2014-08-01 12:33:34 PM DEBUG: Executing on host : ''rm -rf /tmp/tmp9VMILJ'' 2014-08-01 12:33:34 PM DEBUG: setting status pass 2014-08-01 12:33:34 PM DEBUG: finally status pass 2014-08-01 12:33:34 PM INFO: [ACTION-E] deploy_linaro_image is finished successfully. 2014-08-01 12:33:34 PM INFO: [ACTION-B] boot_linaro_image is started with {u'boot_cmds': [u'sendline 2', u'expect or any other key to continue.', u'sendline ']} 2014-08-01 12:33:34 PM INFO: Boot the test image 2014-08-01 12:33:34 PM INFO: Booting the test image. Attempt: 1 2014-08-01 12:33:34 PM WARNING: No INITRD found, [u'uInitrd', u'ramdisk.img', u'initrd.*'] 2014-08-01 12:33:34 PM WARNING: No SECURE FLASHLOADER found, [u'fvp_bl2.bin', u'bl2.bin', u'Bl2.bin', u'bL2.bin', u'BL2.bin'] 2014-08-01 12:33:34 PM WARNING: No SECURE FLASHLOADER found, [u'fvp_bl31.bin', u'bl31.bin', u'Bl31.bin', u'bL31.bin', u'BL31.bin'] 2014-08-01 12:33:34 PM INFO: launching fastmodel with command u'sudo -u lavaserver ARMLMD_LICENSE_FILE="8224@xxxxxxxxx" /home/tekkamanninja/development/aarch64/FastModels/FVP_Base_AEMv8A-AEMv8A/models/Linux64_GCC-4.1/FVP_Base_AEMv8A-AEMv8A -C bp.virtioblockdevice.image_path=/linaro/images/tmp/tmpvrY12w/vexpress64-leg-sd.img -C bp.secure_memory=0 -C bp.smsc_91c111.mac_address="20:12:01:04:10:00" -C pctl.startup=0.0.0.0 -C bp.pl011_uart0.untimed_fifos=1 -C bp.flashloader0.fname=/linaro/images/tmp/tmpvrY12w/fvp_fip.bin -C bp.flashloader1.fname=/linaro/images/tmp/tmpvrY12w/uefi-vars.fd -C bp.secureflashloader.fname=/linaro/images/tmp/tmpvrY12w/bl1.bin -C cluster1.NUM_CORES=4 -C bp.smsc_91c111.enabled=true -C bp.hostbridge.interfaceName="armv8_02" -C bp.flashloader1.fnameWrite=/linaro/images/tmp/tmpvrY12w/uefi-vars.fd -C cache_state_modelled=0 -C cluster0.NUM_CORES=4 ' 2014-08-01 12:33:34 PM DEBUG: expect (300): 'terminal_0: Listening for serial connection on port (\d+)' terminal_0: Listening for serial connection on port 5000 2014-08-01 12:33:34 PM INFO: serial console port on: 5000 2014-08-01 12:33:34 PM DEBUG: expect (1200): '['ERROR: License check failed!', 'Simulation is started']' terminal_1: Listening for serial connection on port 5001 terminal_2: Listening for serial connection on port 5002 terminal_3: Listening for serial connection on port 5003 WARNING: bp.mmc: MMC backing store file mmc.dat could not be used INFO: bp.mmc backing store: no image file connected INFO: bp.flashloader1: FlashLoader: Loaded 0 bytes from file '/linaro/images/tmp/tmpvrY12w/uefi-vars.fd' INFO: bp.flashloader0: FlashLoader: Loaded 2593 kB from file '/linaro/images/tmp/tmpvrY12w/fvp_fip.bin' INFO: bp.secureflashloader: FlashLoader: Loaded 12 kB from file '/linaro/images/tmp/tmpvrY12w/bl1.bin' Simulation is started 2014-08-01 12:34:10 PM DEBUG: expect (1): '['.+', , ]' 2014-08-01 12:34:10 PM INFO: simulator is started connecting to serial port 2014-08-01 12:34:10 PM DEBUG: expect (1): '['.+', , ]' 2014-08-01 12:34:10 PM DEBUG: expect (1200): 'The default boot selection will start in' Trying ::1... Trying 127.0.0.1... Connected to localhost. Escape character is '^]'. Booting trusted firmware boot loader stage 1 v0.4(release): Built : 20:20:04, Aug 1 2014 xterm: Xt error: Can't open display: xterm: DISPLAY is not set 2014-08-01 12:34:11 PM DEBUG: expect (1): '['.+', , ]' Booting trusted firmware boot loader stage 2 BL2 v0.4(release): BL2 Built : 20:20:05, Aug 1 2014 Booting trusted firmware boot loader stage 3 BL31 v0.4(release): BL31 Built : 20:20:08, Aug 1 2014 UEFI firmware (version built at 18:26:47 on Aug 1 2014) [=3h[=3h[=3h[=3h[=3h[=3hThe default boot selection will start in 10 seconds2014-08-01 12:34:13 PM DEBUG: send (delay_ms=0): b 2014-08-01 12:34:13 PM INFO: Overriding boot_cmds from job file 2014-08-01 12:34:13 PM DEBUG: boot_cmds(after preprocessing): [u'sendline 2', u'expect or any other key to continue.', u'sendline '] 2014-08-01 12:34:13 PM DEBUG: send (delay_ms=0): 2 2014-08-01 12:34:13 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:13 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:13 PM DEBUG: expect (300): 'or\ any\ other\ key\ to\ continue\.' [1] Linaro disk image on virtio [2] Shell [3] Boot Manager Start: 2 UEFI Interactive Shell v2.0 EDK II UEFI v2.40 (ARM Fixed Virtual Platform EFI Aug 1 2014 18:27:08, 0x00000000) Mapping table  FS2: Alias(s):F8: VenHw(C5B9C74A-6D72-4719-99AB-C59F199091EB)  FS0: Alias(s):F3: MemoryMapped(0xB,0x88000000,0x8827FFFF)  FS1: Alias(s):F4: MemoryMapped(0xB,0xFEC0E000,0xFEDF50FF)  FS3: Alias(s):HD12b:;BLK5: VenHw(FE61BB5F-1B67-4C24-B346-73DB42E873E5)/HD(1,MBR,0x00000000,0x3F,0x21FC0)  BLK3: Alias(s): VenHw(E7223039-5836-41E1-B542-D7EC736C5E59)  BLK0: Alias(s): VenHw(02118005-9DA7-443A-92D5-781F022AEDBB)  BLK1: Alias(s): VenHw(1F15DA3C-37FF-4070-B471-BB4AF12A724A)  BLK2: Alias(s): VenHw(CC2CBF29-1498-4CDD-8171-F8B6B41D0909)  BLK4: Alias(s): VenHw(FE61BB5F-1B67-4C24-B346-73DB42E873E5)  BLK6: Alias(s): VenHw(FE61BB5F-1B67-4C24-B346-73DB42E873E5)/HD(2,MBR,0x00000000,0x22000,0x3DE000) Press ESC in 5 seconds to skip startup.nsh or any other key to continue.2014-08-01 12:34:15 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:15 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:15 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:15 PM DEBUG: expect (800): 'linaro-test \[rc=(\d+)\]# ' 2014-08-01 12:34:17 PM DEBUG: expect (1): '['.+', , ]' Shell> grub_v8 Welcome to GRUB! GNU GRUB version 2.02~beta2 ÚÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄ¿³³³³³³³³³³³³³³³³³³³³³³³³³³ÀÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÄÙ Use the  and  keys to select which entry is highlighted. Press enter to boot the selected OS, `e' to edit the commands before booting or `c' for a command-line.   FVP base AEMV8 Xen simple test *FVP base AEMV8 Xen test with initramfs and xsm              The highlighted entry will be executed automatically in 1s. 2014-08-01 12:34:23 PM DEBUG: expect (1): '['.+', , ]' 2014-08-01 12:34:29 PM DEBUG: expect (1): '['.+', , ]'  The highlighted entry will be executed automatically in 0s.  Booting `FVP base AEMV8 Xen test with initramfs and xsm' loader/arm64/multiboot.c:458: Multiboot for ARM64 @ Jul 29 2014 10:25:21 loader/arm64/multiboot.c:471: Multiboot kernel: struct grub_file at 0x8fac14a20 loader/arm64/multiboot.c:86: UEFI stub kernel: loader/arm64/multiboot.c:88: text_offset = 0x000000000000 loader/arm64/multiboot.c:89: PE/COFF header @ 00000040 loader/arm64/multiboot.c:52: Assuming the kernel image launched is using fdt! loader/arm64/multiboot_fdt.c:287: Init multiboot_kernel info successfully loader/arm64/multiboot.c:507: Reload alignment from stub header: 0x200000 loader/arm64/multiboot.c:337: Multiboot multiboot_kernel file size: 0xc0678 loader/arm64/multiboot.c:345: Multiboot multiboot_kernel numpages: 0x2c1 loader/arm64/multiboot.c:353: Multiboot multiboot_kernel address align(0x200000) from 0x8bc586000 to 0x8bc600000 loader/arm64/multiboot.c:366: Multiboot multiboot_kernel loaded to 0x8bc600000 size: 0xc0678 loader/arm64/multiboot.c:384: Multiboot multiboot_kernel cmdline @ 0x8fab5e320 no-bootscrub console=dtuart conswitch=x dtuart=serial0 dom0_mem=512M dom0_max_vcpus=2, size: 86 loader/arm64/multiboot_fdt.c:273: Init multiboot,kernel module and node info: compatible multiboot,kernel compatible_size 22 loader/arm64/multiboot.c:337: Multiboot multiboot,kernel file size: 0x4f5700 loader/arm64/multiboot.c:345: Multiboot multiboot,kernel numpages: 0x4f6 loader/arm64/multiboot.c:353: Multiboot multiboot,kernel address align(0x0) from 0x8bc090000 to 0x8bc090000 loader/arm64/multiboot.c:366: Multiboot multiboot,kernel loaded to 0x8bc090000 size: 0x4f5700 loader/arm64/multiboot.c:384: Multiboot multiboot,kernel cmdline @ 0x8faa8e020 console=hvc0 root=/dev/ram0 ro, size: 31 loader/arm64/multiboot_fdt.c:273: Init multiboot,ramdisk module and node info: compatible multiboot,ramdisk compatible_size 23 loader/arm64/multiboot.c:337: Multiboot multiboot,ramdisk file size: 0xb9de00 loader/arm64/multiboot.c:345: Multiboot multiboot,ramdisk numpages: 0xb9e loader/arm64/multiboot.c:353: Multiboot multiboot,ramdisk address align(0x0) from 0x8bb4f2000 to 0x8bb4f2000 2014-08-01 12:34:35 PM DEBUG: expect (1): '['.+', , ]' loader/arm64/multiboot.c:366: Multiboot multiboot,ramdisk loaded to 0x8bb4f2000 size: 0xb9de00 loader/arm64/multiboot.c:390: Multiboot multiboot,ramdisk has not cmdline loader/arm64/multiboot_fdt.c:273: Init xen,xsm-policy module and node info: compatible xen,xsm-policy compatible_size 29 loader/arm64/multiboot.c:337: Multiboot xen,xsm-policy file size: 0x25e7 loader/arm64/multiboot.c:345: Multiboot xen,xsm-policy numpages: 0x3 loader/arm64/multiboot.c:353: Multiboot xen,xsm-policy address align(0x0) from 0x8faca6000 to 0x8faca6000 loader/arm64/multiboot.c:366: Multiboot xen,xsm-policy loaded to 0x8faca6000 size: 0x25e7 loader/arm64/multiboot.c:390: Multiboot xen,xsm-policy has not cmdline loader/arm64/linux.c:121: allocating 10101 bytes for fdt loader/arm64/multiboot_fdt.c:122: Multiboot Kernel cmdline : no-bootscrub console=dtuart conswitch=x dtuart=serial0 dom0_mem=512M dom0_max_vcpus=2 @ 0x8fab5e320 size:86 loader/arm64/multiboot.c:154: Module xen,xsm-policy @ 0x8faca6000 size:0x25e7 loader/arm64/multiboot_fdt.c:153: Module node name module@8faca6000 loader/arm64/multiboot_fdt.c:173: Module xen,xsm-policy compatible = xen,xsm-policy size = 29 loader/arm64/multiboot_fdt.c:195: Module xen,xsm-policy has not bootargs! loader/arm64/multiboot.c:154: Module multiboot,ramdisk @ 0x8bb4f2000 size:0xb9de00 loader/arm64/multiboot_fdt.c:153: Module node name module@8bb4f2000 loader/arm64/multiboot_fdt.c:173: Module multiboot,ramdisk compatible = multiboot,ramdisk size = 23 loader/arm64/multiboot_fdt.c:195: Module multiboot,ramdisk has not bootargs! loader/arm64/multiboot.c:154: Module multiboot,kernel @ 0x8bc090000 size:0x4f5700 loader/arm64/multiboot_fdt.c:153: Module node name module@8bc090000 loader/arm64/multiboot_fdt.c:173: Module multiboot,kernel compatible = multiboot,kernel size = 22 loader/arm64/multiboot_fdt.c:185: Module multiboot,kernel cmdline : console=hvc0 root=/dev/ram0 ro @ 0x8faa8e020 size:31 loader/arm64/multiboot_fdt.c:217: Installed/updated FDT configuration table @ 0x8faca3000 loader/arm64/multiboot.c:258: starting stub-kernel @ 0x8fe956298 Xen 4.5-unstable (c/s ) EFI loader - UART enabled - - CPU 00000000 booting - - Current EL 00000008 - - Xen starting at EL2 - - Zero BSS - - Setting up control registers - - Turning on paging - - Ready - (XEN) Checking for initrd in /chosen (XEN) RAM: 0000000080000000 - 00000000ffffffff (XEN) RAM: 0000000880000000 - 00000008ffffffff (XEN) (XEN) MODULE[0]: 00000008faca3000 - 00000008faca5775 Device Tree (XEN) MODULE[1]: 00000008bc090000 - 00000008bc585700 Kernel console=hvc0 root=/dev/ram0 ro (XEN) MODULE[2]: 00000008bb4f2000 - 00000008bc08fe00 Ramdisk (XEN) MODULE[3]: 00000008faca6000 - 00000008faca85e7 XSM (XEN) RESVD[0]: 0000000080000000 - 0000000080010000 (XEN) (XEN) Command line: no-bootscrub console=dtuart conswitch=x dtuart=serial0 dom0_mem=512M dom0_max_vcpus=2 (XEN) Placing Xen at 0x00000000ffe00000-0x0000000100000000 (XEN) Update BOOTMOD_XEN from 00000008bb200000-00000008bb314d81 => 00000000ffe00000-00000000fff14d81 (XEN) PFN compression on bits 20...22 2014-08-01 12:34:41 PM DEBUG: expect (1): '['.+', , ]' (XEN) Domain heap initialised (XEN) Looking for UART console serial0 Xen 4.5-unstable (XEN) Xen version 4.5-unstable (tekkamanninja@) (aarch64-linux-gnu-gcc (crosstool-NG linaro-1.13.1-4.9-2014.05 - Linaro GCC 4.9-2014.05) 4.9.1 20140505 (prerelease)) debug=y Fri Aug 1 20:30:30 CST 2014 (XEN) Latest ChangeSet: (XEN) Processor: 410fd0f0: "ARM Limited", variant: 0x0, part 0xd0f, rev 0x0 (XEN) 64-bit Execution: (XEN) Processor Features: 0000000001002222 0000000000000000 (XEN) Exception Levels: EL3:64+32 EL2:64+32 EL1:64+32 EL0:64+32 (XEN) Extensions: FloatingPoint AdvancedSIMD (XEN) Debug Features: 00000000f0f0f106 0000000000000000 (XEN) Auxiliary Features: 0000000000000000 0000000000000000 (XEN) Memory Model Features: 0000000000001122 0000000000000000 (XEN) ISA Features: 0000000000000000 0000000000000000 (XEN) 32-bit Execution: (XEN) Processor Features: 00000131:10011011 (XEN) Instruction Sets: AArch32 Thumb Thumb-2 Jazelle (XEN) Extensions: GenericTimer Security (XEN) Debug Features: 03010066 (XEN) Auxiliary Features: 00000000 (XEN) Memory Model Features: 10101105 20000000 01260000 02102111 (XEN) ISA Features: 02101110 13112111 21232042 01112131 00011142 00000001 (XEN) Platform: VERSATILE EXPRESS (XEN) Using PSCI for SMP bringup (XEN) Generic Timer IRQ: phys=30 hyp=26 virt=27 (XEN) Using generic timer at 100000 KHz (XEN) GICv2 initialization: (XEN) gic_dist_addr=000000002f000000 (XEN) gic_cpu_addr=000000002c000000 (XEN) gic_hyp_addr=000000002c010000 (XEN) gic_vcpu_addr=000000002c02f000 (XEN) gic_maintenance_irq=25 (XEN) GICv2: 256 lines, 8 cpus, secure (IID 00000000). (XEN) XSM Framework v1.0.0 initialized (XEN) xsm: Policy len = 0x00000000000025e7 start at 0x00000008faca6000 (XEN) Flask: Initializing. (XEN) AVC INITIALIZED (XEN) Flask: 128 avtab hash slots, 276 rules. (XEN) Flask: 128 avtab hash slots, 276 rules. (XEN) Flask: 3 users, 3 roles, 39 types, 1 bools (XEN) Flask: 11 classes, 276 rules (XEN) Flask: permission create_hardware_domain in class domain2 not defined in policy (XEN) Flask: the definition of a class is incorrect (XEN) Flask: Starting in permissive mode. (XEN) Using scheduler: SMP Credit Scheduler (credit) (XEN) I/O virtualisation disabled (XEN) Allocated console ring of 64 KiB. (XEN) Bringing up CPU1 - CPU 00000001 booting - - Current EL 00000008 - - Xen starting at EL2 - - Setting up control registers - - Turning on paging - - Ready - (XEN) CPU 1 booted. (XEN) Bringing up CPU2 - CPU 00000002 booting - - Current EL 00000008 - - Xen starting at EL2 - - Setting up control registers - - Turning on paging - - Ready - (XEN) CPU 2 booted. (XEN) Bringing up CPU3 - CPU 00000003 booting - - Current EL 00000008 - - Xen starting at EL2 - - Setting up control registers - - Turning on paging - - Ready - (XEN) CPU 3 booted. (XEN) Bringing up CPU4 - CPU 00000100 booting - - Current EL 00000008 - - Xen starting at EL2 - - Setting up control registers - - Turning on paging - - Ready - (XEN) CPU 4 booted. (XEN) Bringing up CPU5 - CPU 00000101 booting - - Current EL 00000008 - - Xen starting at EL2 - - Setting up control registers - - Turning on paging - - Ready - (XEN) CPU 5 booted. (XEN) Bringing up CPU6 - CPU 00000102 booting - - Current EL 00000008 - - Xen starting at EL2 - - Setting up control registers - - Turning on paging - - Ready - (XEN) CPU 6 booted. (XEN) Bringing up CPU7 - CPU 00000103 booting - - Current EL 00000008 - - Xen starting at EL2 - - Setting up control registers - - Turning on paging - - Ready - (XEN) CPU 7 booted. (XEN) Brought up 8 CPUs (XEN) *** LOADING DOMAIN 0 *** (XEN) Loading kernel from boot module @ 00000008bc090000 (XEN) Loading ramdisk from boot module @ 00000008bb4f2000 (XEN) Allocating 1:1 mappings totalling 512MB for dom0: 2014-08-01 12:34:47 PM DEBUG: expect (1): '['.+', , ]' (XEN) BANK[0] 0x000000a0000000-0x000000c0000000 (512MB) (XEN) Loading zImage from 00000008bc090000 to 00000000a0080000-00000000a0575700 (XEN) Loading dom0 initrd from 00000008bb4f2000 to 0x00000000a8200000-0x00000000a8d9de00 (XEN) Loading dom0 DTB to 0x00000000a8000000-0x00000000a800212a (XEN) Std. Loglevel: All (XEN) Guest Loglevel: All (XEN) *** Serial input -> DOM0 (type 'CTRL-x' three times to switch input to Xen) (XEN) Freed 252kB init memory. 2014-08-01 12:34:53 PM DEBUG: expect (1): '['.+', , ]' Linux version 3.16.0-rc1 (tekkamanninja@Super-MAGI) (gcc version 4.9.1 20140505 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.05 - Linaro GCC 4.9-2014.05) ) #4 Tue Jun 17 15:01:55 CST 2014 CPU: AArch64 Processor [410fd0f0] revision 0 efi: Getting parameters from FDT: efi: Can't find System Table in device tree! psci: probing for conduit method from DT. psci: Using PSCI v0.1 Function IDs from DT /cpus/cpu@0: unsupported enable-method property: psci Built 1 zonelists in Zone order, mobility grouping on. Total pages: 129280 Kernel command line: console=hvc0 root=/dev/ram0 ro PID hash table entries: 2048 (order: 2, 16384 bytes) Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) Memory: 491856K/524288K available (3678K kernel code, 273K rwdata, 960K rodata, 160K init, 202K bss, 32432K reserved) Virtual kernel memory layout: vmalloc : 0xffffff8000000000 - 0xffffffbbffff0000 (245759 MB) vmemmap : 0xffffffbc02300000 - 0xffffffbc02a00000 ( 7 MB) modules : 0xffffffbffc000000 - 0xffffffc000000000 ( 64 MB) memory : 0xffffffc000000000 - 0xffffffc020000000 ( 512 MB) .init : 0xffffffc000509000 - 0xffffffc000531000 ( 160 kB) .text : 0xffffffc000080000 - 0xffffffc000508194 ( 4641 kB) .data : 0xffffffc000531000 - 0xffffffc000575700 ( 274 kB) NR_IRQS:64 nr_irqs:64 0 Architected cp15 and mmio timer(s) running at 100.00MHz (virt/phys). sched_clock: 56 bits at 100MHz, resolution 10ns, wraps every 2748779069440ns Console: colour dummy device 80x25 Calibrating delay loop (skipped), value calculated using timer frequency.. 200.00 BogoMIPS (lpj=1000000) pid_max: default: 32768 minimum: 301 Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) EFI services will not be available. Xen 4.5 support found, events_irq=31 gnttab_frame=0x00000000b0000000 xen:grant_table: Grant tables using version 1 layout Grant table initialized xen:events: Using FIFO-based ABI Xen: initializing cpu0 devtmpfs: initialized NET: Registered protocol family 16 vdso: 2 pages (1 code, 1 data) at base ffffffc000539000 software IO TLB [mem 0xbe400000-0xbe800000] (4MB) mapped at [ffffffc01e400000-ffffffc01e7fffff] software IO TLB [mem 0xbe000000-0xbe400000] (4MB) mapped at [ffffffc01e000000-ffffffc01e3fffff] Serial: AMBA PL011 UART driver of_amba_device_create(): amba_device_add() failed (-19) for /smb/motherboard/iofpga@3,00000000/sysctl@020000 1c0a0000.uart: ttyAMA1 at MMIO 0x1c0a0000 (irq = 38, base_baud = 0) is a PL011 rev2 1c0b0000.uart: ttyAMA2 at MMIO 0x1c0b0000 (irq = 39, base_baud = 0) is a PL011 rev2 1c0c0000.uart: ttyAMA3 at MMIO 0x1c0c0000 (irq = 40, base_baud = 0) is a PL011 rev2 xen:balloon: Initialising balloon driver xen_balloon: Initialising balloon driver SCSI subsystem initialized usbcore: registered new interface driver usbfs usbcore: registered new interface driver hub usbcore: registered new device driver usb Advanced Linux Sound Architecture Driver Initialized. Switched to clocksource arch_sys_counter NET: Registered protocol family 2 TCP established hash table entries: 4096 (order: 3, 32768 bytes) TCP bind hash table entries: 4096 (order: 3, 32768 bytes) TCP: Hash tables configured (established 4096 bind 4096) TCP: reno registered UDP hash table entries: 256 (order: 1, 8192 bytes) UDP-Lite hash table entries: 256 (order: 1, 8192 bytes) NET: Registered protocol family 1 RPC: Registered named UNIX socket transport module. RPC: Registered udp transport module. RPC: Registered tcp transport module. RPC: Registered tcp NFSv4.1 backchannel transport module. Trying to unpack rootfs image as initramfs... Freeing initrd memory: 11892K (ffffffc008200000 - ffffffc008d9d000) futex hash table entries: 256 (order: 0, 6144 bytes) Installing knfsd (copyright (C) 1996 okir@xxxxxxxxxxxx). jffs2: version 2.2. (NAND) © 2001-2006 Red Hat, Inc. ROMFS MTD (C) 2007 Red Hat, Inc. msgmni has been set to 983 Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254) io scheduler noop registered io scheduler deadline registered io scheduler cfq registered (default) clcd-pl11x: probe of 1c1f0000.clcd failed with error -22 xen:xen_evtchn: Event-channel device installed console [hvc0] enabled Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled brd: module loaded loop: module loaded tun: Universal TUN/TAP device driver, 1.6 tun: (C) 1999-2004 Max Krasnyansky smc91x 1a000000.ethernet (unregistered net_device): smc91x: IOADDR ffffff80000bc000 doesn't match configuration (300). smc91x.c: v1.1, sep 22 2004 by Nicolas Pitre smc91x 1a000000.ethernet eth0: SMC91C11xFD (rev 1) at ffffff80000bc000 IRQ 47 smc91x 1a000000.ethernet eth0: Ethernet addr: 20:12:01:04:10:00 xen_netfront: Initialising Xen virtual ethernet driver usbcore: registered new interface driver usb-storage mousedev: PS/2 mouse device common for all mice i2c /dev entries driver mmci-pl18x 1c050000.mmci: Got CD GPIO #254. mmci-pl18x 1c050000.mmci: Got WP GPIO #255. mmci-pl18x 1c050000.mmci: No vmmc regulator found mmci-pl18x 1c050000.mmci: No vqmmc regulator found mmci-pl18x 1c050000.mmci: mmc0: PL180 manf 41 rev0 at 0x1c050000 irq 41,42 (pio) sdhci: Secure Digital Host Controller Interface driver sdhci: Copyright(c) Pierre Ossman sdhci-pltfm: SDHCI platform and OF driver helper usbcore: registered new interface driver usbhid usbhid: USB HID core driver TCP: cubic registered NET: Registered protocol family 17 ALSA device list: No soundcards found. Freeing unused kernel memory: 160K (ffffffc000509000 - ffffffc000531000) linaro-test [rc=0]# 2014-08-01 12:34:56 PM INFO: System is in test image now 2014-08-01 12:34:56 PM DEBUG: mount information 2014-08-01 12:34:56 PM DEBUG: send (delay_ms=0): mount 2014-08-01 12:34:56 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:56 PM DEBUG: expect (800): 'linaro-test \[rc=(\d+)\]# ' input: AT Raw Set 2 keyboard as /devices/smb/smb:motherboard/smb:motherboard:iofpga@3,00000000/1c060000.kmi/serio0/input/input0 mount rootfs on / type rootfs (rw) proc on /proc type proc (rw,relatime) sysfs on /sys type sysfs (rw,relatime) none on /dev type devtmpfs (rw,relatime,size=245928k,nr_inodes=61482,mode=755) linaro-test [rc=0]# 2014-08-01 12:34:56 PM DEBUG: root directory information 2014-08-01 12:34:56 PM DEBUG: send (delay_ms=0): ls -l / 2014-08-01 12:34:57 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:57 PM DEBUG: expect (800): 'linaro-test \[rc=(\d+)\]# ' ls -l / total 4 drwxr-xr-x 2 root root 0 Jun 17 2014 bin drwxr-xr-x 2 root root 0 Jun 17 2014 boot drwxr-xr-x 6 root root 3220 Jan 1 00:00 dev drwxr-xr-x 8 root root 0 Jun 17 2014 etc drwxr-xr-x 3 root root 0 Jun 17 2014 home -rwxr-xr-x 1 root root 916 Jun 17 2014 init drwxr-xr-x 2 root root 0 Jun 17 2014 lib drwxr-xr-x 2 root root 0 Jun 17 2014 media drwxr-xr-x 2 root root 0 Jun 17 2014 mnt dr-xr-xr-x 42 root root 0 Jan 1 00:00 proc drwx------ 2 root root 0 Jun 17 2014 root drwxr-xr-x 2 root root 0 Jan 1 00:00 run drwxr-xr-x 2 root root 0 Jun 17 2014 sbin dr-xr-xr-x 12 root root 0 Jan 1 00:00 sys drwxrwxrwt 2 root root 0 Jun 17 2014 tmp drwxr-xr-x 9 root root 0 Jun 17 2014 usr drwxr-xr-x 7 root root 0 Jun 17 2014 var linaro-test [rc=0]# 2014-08-01 12:34:57 PM DEBUG: free space information 2014-08-01 12:34:57 PM DEBUG: send (delay_ms=0): df -h 2014-08-01 12:34:57 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:57 PM DEBUG: expect (800): 'linaro-test \[rc=(\d+)\]# ' dfinput: PS/2 Generic Mouse as /devices/smb/smb:motherboard/smb:motherboard:iofpga@3,00000000/1c070000.kmi/serio1/input/input2 -h Filesystem Size Used Available Use% Mounted on none 240.2M 0 240.2M 0% /dev linaro-test [rc=0]# 2014-08-01 12:34:57 PM DEBUG: IP addr information 2014-08-01 12:34:57 PM DEBUG: send (delay_ms=0): ip addr 2014-08-01 12:34:58 PM DEBUG: send (delay_ms=0): 2014-08-01 12:34:58 PM DEBUG: expect (800): 'linaro-test \[rc=(\d+)\]# ' ip addr 1: lo: mtu 65536 qdisc noop link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 2: eth0: mtu 1500 qdisc noop qlen 1000 link/ether 20:12:01:04:10:00 brd ff:ff:ff:ff:ff:ff linaro-test [rc=0]# 2014-08-01 12:34:58 PM DEBUG: Checking for vm-group host 2014-08-01 12:34:58 PM DEBUG: setting status pass 2014-08-01 12:34:58 PM DEBUG: finally status pass 2014-08-01 12:34:58 PM INFO: [ACTION-E] boot_linaro_image is finished successfully. 2014-08-01 12:34:59 PM DEBUG: expect (1): '['.+', , ]' simulation is shutting down, please wait ... Simulation is terminating. Reason: termination request 2014-08-01 12:34:59 PM DEBUG: expect (1): '['.+', , ]' INFO: bp.flashloader1: FlashLoader: Saved 64MB to file '/linaro/images/tmp/tmpvrY12w/uefi-vars.fd' 2014-08-01 12:34:59 PM DEBUG: expect (1): '['.+', , ]' 2014-08-01 12:35:03 PM DEBUG: Finalizing child process group with PID 28814 signal 15 2014-08-01 12:35:03 PM INFO: Submitting the test result with parameters = {u'token': '', u'stream': u'/anonymous/tekkamanninja/', u'server': u'http://tekkamanninja@xxxxxxxxxxxx/RPC2/'} 2014-08-01 12:35:03 PM DEBUG: server RPC endpoint URL: http://tekkamanninja@xxxxxxxxxxxx/RPC2/ 2014-08-01 12:35:03 PM INFO: Dashboard : http://192.168.1.16/dashboard/permalink/bundle/14c0e1d34af776d8dac4c3f145d1e22c8dc62d28/