7 Replies Latest reply on Jun 30, 2011 9:34 AM by antonvank

Building EBS on micro AMI, does not finish, ideas?

antonvank Jun 29, 2011 1:32 PM

I read comments about failing atempts building and ebs VM on Amazon. I'm not having having problems with the first steps though, After it has finished the ec2 format the application (the latest) simply doesn't finish nor report. The VM is running 100% CPU and doesn't progress it has been running without memory adjustments for more than a day, without finishing. It looks like it fails on ec2 without noticing, on the other hand that is not the final output so I may be just the logging telling that there are only 0 bytes.

The logging is pretty long so its short shorted:

The appl specifies the @core and a number of packages like samba, php etc

boxgrinder-build f14-base.appl -p ec2 -d ebs -b --debug

D, [2011-06-29T15:33:12.489061 #816] DEBUG -- : Launching new BoxGrinder build...

D, [2011-06-29T15:33:12.508489 #816] DEBUG -- : Loading os plugins...

D, [2011-06-29T15:33:12.508696 #816] DEBUG -- : We have 3 os plugin(s) registered

D, [2011-06-29T15:33:12.508875 #816] DEBUG -- : - fedora plugin for Fedora.

D, [2011-06-29T15:33:12.509050 #816] DEBUG -- : - centos plugin for CentOS.

D, [2011-06-29T15:33:12.509224 #816] DEBUG -- : - rhel plugin for Red Hat Enterprise Linux.

D, [2011-06-29T15:33:12.509392 #816] DEBUG -- : Plugins loaded.

D, [2011-06-29T15:33:12.509717 #816] DEBUG -- : Loading platform plugins...

D, [2011-06-29T15:33:12.509910 #816] DEBUG -- : We have 3 platform plugin(s) registered

D, [2011-06-29T15:33:12.510086 #816] DEBUG -- : - virtualbox plugin for VirtualBox.

D, [2011-06-29T15:33:12.510260 #816] DEBUG -- : - ec2 plugin for Amazon Elastic Compute Cloud (Amazon EC2).

D, [2011-06-29T15:33:12.510434 #816] DEBUG -- : - vmware plugin for VMware.

D, [2011-06-29T15:33:12.510753 #816] DEBUG -- : Plugins loaded.

D, [2011-06-29T15:33:12.510927 #816] DEBUG -- : Loading delivery plugins...

D, [2011-06-29T15:33:12.511116 #816] DEBUG -- : We have 7 delivery plugin(s) registered

D, [2011-06-29T15:33:12.511294 #816] DEBUG -- : - ebs plugin for Elastic Block Storage.

D, [2011-06-29T15:33:12.511467 #816] DEBUG -- : - s3 plugin for Amazon Simple Storage Service (Amazon S3).

D, [2011-06-29T15:33:12.511765 #816] DEBUG -- : - elastichosts plugin for ElasticHosts.

D, [2011-06-29T15:33:12.511940 #816] DEBUG -- : - sftp plugin for SSH File Transfer Protocol.

D, [2011-06-29T15:33:12.512113 #816] DEBUG -- : - local plugin for Local file system.

D, [2011-06-29T15:33:12.512285 #816] DEBUG -- : - cloudfront plugin for Amazon Simple Storage Service (Amazon S3).

D, [2011-06-29T15:33:12.512459 #816] DEBUG -- : - ami plugin for Amazon Simple Storage Service (Amazon S3).

D, [2011-06-29T15:33:12.512750 #816] DEBUG -- : Plugins loaded.

I, [2011-06-29T15:33:12.520166 #816] INFO -- : Validating appliance definition from f14-base.appl file...

I, [2011-06-29T15:33:12.534112 #816] INFO -- : Appliance definition is valid.

D, [2011-06-29T15:33:12.534451 #816] DEBUG -- : Adding packages to appliance...

D, [2011-06-29T15:33:12.534764 #816] DEBUG -- : 9 package(s) added to appliance.

I, [2011-06-29T15:33:12.544905 #816] INFO -- : Building 'f14-Speech' appliance for i686 architecture.

I, [2011-06-29T15:33:12.549628 #816] INFO -- : Deliverables for fedora operating system plugin exists, skipping.

D, [2011-06-29T15:33:12.550723 #816] DEBUG -- : Executing platform plugin for ec2...

I, [2011-06-29T15:33:12.560765 #816] INFO -- : Converting f14-Speech appliance image to EC2 format...

D, [2011-06-29T15:33:12.561156 #816] DEBUG -- : Executing command: 'dd if=/dev/zero of='build/appliances/i686/fedora/14/f14-Speech/ec2-plugin/tmp/f14-Speech.ec2' bs=1 count=0 seek=10240M'

D, [2011-06-29T15:33:12.583399 #816] DEBUG -- : 0+0 records in

D, [2011-06-29T15:33:12.583847 #816] DEBUG -- : 0+0 records out

D, [2011-06-29T15:33:12.584188 #816] DEBUG -- : 0 bytes (0 B) copied, 1.8539e-05 s, 0.0 kB/s

D, [2011-06-29T15:33:12.585207 #816] DEBUG -- : Preparing guestfs...

D, [2011-06-29T15:33:12.630096 #816] DEBUG -- : Enabling networking for GuestFS...

D, [2011-06-29T15:33:12.630849 #816] DEBUG -- : Launching guestfs...

D, [2011-06-29T15:33:12.642255 #816] DEBUG -- : GFS: [00008ms] febootstrap-supermin-helper --verbose -f checksum '/usr/lib/guestfs/supermin.d' i686

supermin helper [00000ms] whitelist = (not specified), host_cpu = i686, kernel = (null), initrd = (null), appliance = (null)

supermin helper [00000ms] inputs[0] = /usr/lib/guestfs/supermin.d

checking modpath /lib/modules/2.6.38.6-26.rc1.fc15.i686.PAE is a directory

picked vmlinuz-2.6.38.6-26.rc1.fc15.i686.PAE because modpath /lib/modules/2.6.38.6-26.rc1.fc15.i686.PAE exists

supermin helper [00008ms] finished creating kernel

supermin helper [00008ms] visiting /usr/lib/guestfs/supermin.d

supermin helper [00017ms] visiting /usr/lib/guestfs/supermin.d/base.img

supermin helper [00043ms] visiting /usr/lib/guestfs/supermin.d/daemon.img

supermin helper [00045ms] visiting /usr/lib/guestfs/supermin.d/hostfiles

supermin helper [00465ms] visiting /usr/lib/guestfs/supermin.d/init.img

supermin helper [01000ms] finished creating appliance

logging skipped

D, [2011-06-29T15:35:30.963756 #816] DEBUG -- : SELinux policy was loaded, we're ready to sync filesystem.

I, [2011-06-29T15:35:30.963960 #816] INFO -- : Synchronizing filesystems...

D, [2011-06-29T15:35:30.965962 #816] DEBUG -- : GFS: send_to_daemon: 52 bytes: 00 00 00 30 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 00 | ...

D, [2011-06-29T15:35:30.967303 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 45 (umount) took 0.49 seconds

D, [2011-06-29T15:35:30.969144 #816] DEBUG -- : GFS: guestfsd: main_loop: new request, len 0x30

D, [2011-06-29T15:35:30.971042 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 01 | 00 12 34 11 | ...

D, [2011-06-29T15:35:30.971849 #816] DEBUG -- : GFS: send_to_daemon: 52 bytes: 00 00 00 30 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 00 | ...

D, [2011-06-29T15:35:30.973821 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 148 (mkmountpoint) took 0.00 seconds

guestfsd: main_loop: new request, len 0x30

D, [2011-06-29T15:35:30.974904 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 01 | 00 12 34 12 | ...

D, [2011-06-29T15:35:30.975465 #816] DEBUG -- : GFS: send_to_daemon: 56 bytes: 00 00 00 34 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 00 | ...

D, [2011-06-29T15:35:30.977208 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 148 (mkmountpoint) took 0.00 seconds

guestfsd: main_loop: new request, len 0x34

D, [2011-06-29T15:35:30.978397 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 01 | 00 12 34 13 | ...

D, [2011-06-29T15:35:30.979097 #816] DEBUG -- : GFS: send_to_daemon: 64 bytes: 00 00 00 3c | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 2a | 00 00 00 00 | ...

D, [2011-06-29T15:35:30.980902 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 148 (mkmountpoint) took 0.00 seconds

guestfsd: main_loop: new request, len 0x3c

D, [2011-06-29T15:35:30.985010 #816] DEBUG -- : GFS: mke2fs -t ext4 -F /dev/vdb

D, [2011-06-29T15:35:31.110156 #816] DEBUG -- : GFS: mke2fs 1.41.14 (22-Dec-2010)

D, [2011-06-29T15:35:57.515534 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 2a | 00 00 00 01 | 00 12 34 14 | ...

D, [2011-06-29T15:35:57.516287 #816] DEBUG -- : GFS: send_to_daemon: 68 bytes: 00 00 00 40 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...

D, [2011-06-29T15:35:57.518602 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 42 (mkfs) took 12.45 seconds

guestfsd: main_loop: new request, len 0x40

D, [2011-06-29T15:35:57.522727 #816] DEBUG -- : GFS: e2label /dev/vdb 79d3d2d4

D, [2011-06-29T15:35:57.524533 #816] DEBUG -- : GFS:

D, [2011-06-29T15:35:57.793806 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 15 | ...

D, [2011-06-29T15:35:57.794812 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 00 | ...

D, [2011-06-29T15:35:57.796893 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.27 seconds

guestfsd: main_loop: new request, len 0x44

D, [2011-06-29T15:35:57.799600 #816] DEBUG -- : GFS: mount -o /dev/vdb /sysroot/out/in

D, [2011-06-29T15:35:58.180817 #816] DEBUG -- : GFS: [ 51.942588] EXT4-fs (vdb): mounted filesystem with ordered data mode. Opts: (null)

D, [2011-06-29T15:35:58.242592 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 01 | 00 12 34 16 | ...

D, [2011-06-29T15:35:58.243290 #816] DEBUG -- : GFS: send_to_daemon: 68 bytes: 00 00 00 40 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...

D, [2011-06-29T15:35:58.245608 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 74 (mount_options) took 0.43 seconds

guestfsd: main_loop: new request, len 0x40

D, [2011-06-29T15:35:58.249234 #816] DEBUG -- : GFS: e2label /dev/vdb a570ee9c

D, [2011-06-29T15:35:58.584214 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 17 | ...

D, [2011-06-29T15:35:58.585441 #816] DEBUG -- : GFS: send_to_daemon: 44 bytes: 00 00 00 28 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 00 | ...

D, [2011-06-29T15:35:58.587701 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.33 seconds

guestfsd: main_loop: new request, len 0x28

D, [2011-06-29T15:35:58.591894 #816] DEBUG -- : GFS: recv_from_daemon: 76 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 01 | 00 12 34 18 | ...

D, [2011-06-29T15:35:58.592900 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 00 | ...

D, [2011-06-29T15:35:58.596294 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 8 (list_partitions) took 0.00 seconds

guestfsd: main_loop: new request, len 0x44

D, [2011-06-29T15:35:58.598997 #816] DEBUG -- : GFS: mount -o /dev/vda1 /sysroot/in/

D, [2011-06-29T15:35:58.985736 #816] DEBUG -- : GFS: [ 52.732800] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)

D, [2011-06-29T15:35:59.079258 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 01 | 00 12 34 19 | ...

D, [2011-06-29T15:35:59.080133 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...

D, [2011-06-29T15:35:59.102597 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 74 (mount_options) took 0.47 seconds

D, [2011-06-29T15:35:59.105309 #816] DEBUG -- : GFS: guestfsd: main_loop: new request, len 0x44

D, [2011-06-29T15:35:59.121735 #816] DEBUG -- : GFS: e2label /dev/vda1 79d3d2d4

D, [2011-06-29T15:35:59.257056 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 1a | ...

D, [2011-06-29T15:35:59.258439 #816] DEBUG -- : GFS: send_to_daemon: 84 bytes: 00 00 00 50 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 00 | ...

D, [2011-06-29T15:35:59.260397 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.15 seconds

guestfsd: main_loop: new request, len 0x50

D, [2011-06-29T15:35:59.274709 #816] DEBUG -- : GFS: mount -o /dev/vda2 /sysroot/in/SpeechMagic

D, [2011-06-29T15:35:59.621513 #816] DEBUG -- : GFS: [ 53.345371] EXT4-fs (vda2): mounted filesystem with ordered data mode. Opts: (null)

D, [2011-06-29T15:35:59.649809 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 01 | 00 12 34 1b | ...

D, [2011-06-29T15:35:59.650726 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...

D, [2011-06-29T15:35:59.652580 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 74 (mount_options) took 0.37 seconds

guestfsd: main_loop: new request, len 0x44

D, [2011-06-29T15:35:59.657196 #816] DEBUG -- : GFS: e2label /dev/vda2 d8863c17

D, [2011-06-29T15:35:59.762017 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 1c | ...

D, [2011-06-29T15:35:59.762861 #816] DEBUG -- : Copying files...

D, [2011-06-29T15:35:59.763310 #816] DEBUG -- : GFS: send_to_daemon: 60 bytes: 00 00 00 38 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 58 | 00 00 00 00 | ...

D, [2011-06-29T15:35:59.765252 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.10 seconds

guestfsd: main_loop: new request, len 0x38

D, [2011-06-29T15:35:59.792747 #816] DEBUG -- : GFS: cp -a /sysroot/in/ /sysroot/out

From here on the system runs at 100% CPU, you cannot even login through another connection

1. Re: Building EBS on micro AMI, does not finish, ideas?

goldmann Jun 30, 2011 5:23 AM (in response to antonvank)
Anton,

I think you were hit by the low RAM amount on micro isntances. Libguestfs uses by default 500 MB of ram to run which may be a problem on micro isntance You can decrease it for example to 300 by setting the environment variable:

export LIBGUESTFS_MEMSIZE=300

--Marek
Actions
2. Re: Building EBS on micro AMI, does not finish, ideas?

antonvank Jun 30, 2011 5:51 AM (in response to goldmann)

Marek,

You are right for the first couple of tries, I however then read the thread about the memory usage and reduced it with your above setting and ran it with debug information of which the above is the result. So unfortunately there is no info that that it needs more memory in the log. I had to stop the VM as it kept running without making progress and bypassed the problem by building a VM from the base appliance, but really would like this to work. So how can I provide more info?

--Anton
Actions
3. Re: Building EBS on micro AMI, does not finish, ideas?

goldmann Jun 30, 2011 6:01 AM (in response to antonvank)

Basically we would need a trace log level, which can be provided by pasting relevant part of log/boxgrinder.log.

--Marek
Actions
4. Re: Building EBS on micro AMI, does not finish, ideas?

antonvank Jun 30, 2011 6:37 AM (in response to goldmann)

I have added it completely as it wasn't too big

D, [2011-06-29T15:33:12.489243 #816] DEBUG -- : Launching new BoxGrinder build...
T, [2011-06-29T15:33:12.508324 #816] TRACE -- : Used configuration: --- !map:BoxGrinder::Config
:file: /root/.boxgrinder/config
:force: false
:platform_config: {}

:log_level: :debug
:delivery_config: {}

:additional_plugins: []

:backtrace: true
:dir:
:cache: /var/cache/boxgrinder
:root: /appliances
:build: build
:tmp: /tmp
:delivery: :ebs
:name: BoxGrinder Build
:os_config: {}

:plugins:
ebs:
    delete_on_termination: false
    access_key: <REDACTED>
    account_number: <REDACTED>
    secret_access_key: <REDACTED>
:platform: :ec2

D, [2011-06-29T15:33:12.508595 #816] DEBUG -- : Loading os plugins...
D, [2011-06-29T15:33:12.508777 #816] DEBUG -- : We have 3 os plugin(s) registered
D, [2011-06-29T15:33:12.508954 #816] DEBUG -- : - fedora plugin for Fedora.
D, [2011-06-29T15:33:12.509129 #816] DEBUG -- : - centos plugin for CentOS.
D, [2011-06-29T15:33:12.509303 #816] DEBUG -- : - rhel plugin for Red Hat Enterprise Linux.
D, [2011-06-29T15:33:12.509472 #816] DEBUG -- : Plugins loaded.
D, [2011-06-29T15:33:12.509816 #816] DEBUG -- : Loading platform plugins...
D, [2011-06-29T15:33:12.509990 #816] DEBUG -- : We have 3 platform plugin(s) registered
D, [2011-06-29T15:33:12.510165 #816] DEBUG -- : - virtualbox plugin for VirtualBox.
D, [2011-06-29T15:33:12.510340 #816] DEBUG -- : - ec2 plugin for Amazon Elastic Compute Cloud (Amazon EC2).
D, [2011-06-29T15:33:12.510513 #816] DEBUG -- : - vmware plugin for VMware.
D, [2011-06-29T15:33:12.510836 #816] DEBUG -- : Plugins loaded.
D, [2011-06-29T15:33:12.511007 #816] DEBUG -- : Loading delivery plugins...
D, [2011-06-29T15:33:12.511198 #816] DEBUG -- : We have 7 delivery plugin(s) registered
D, [2011-06-29T15:33:12.511374 #816] DEBUG -- : - ebs plugin for Elastic Block Storage.
D, [2011-06-29T15:33:12.511658 #816] DEBUG -- : - s3 plugin for Amazon Simple Storage Service (Amazon S3).
D, [2011-06-29T15:33:12.511846 #816] DEBUG -- : - elastichosts plugin for ElasticHosts.
D, [2011-06-29T15:33:12.512020 #816] DEBUG -- : - sftp plugin for SSH File Transfer Protocol.
D, [2011-06-29T15:33:12.512191 #816] DEBUG -- : - local plugin for Local file system.
D, [2011-06-29T15:33:12.512365 #816] DEBUG -- : - cloudfront plugin for Amazon Simple Storage Service (Amazon S3).
D, [2011-06-29T15:33:12.512649 #816] DEBUG -- : - ami plugin for Amazon Simple Storage Service (Amazon S3).
D, [2011-06-29T15:33:12.512831 #816] DEBUG -- : Plugins loaded.
I, [2011-06-29T15:33:12.520272 #816] INFO -- : Validating appliance definition from f14-base.appl file...
I, [2011-06-29T15:33:12.534210 #816] INFO -- : Appliance definition is valid.
D, [2011-06-29T15:33:12.534653 #816] DEBUG -- : Adding packages to appliance...
D, [2011-06-29T15:33:12.534846 #816] DEBUG -- : 9 package(s) added to appliance.
I, [2011-06-29T15:33:12.545136 #816] INFO -- : Building 'f14-Speech' appliance for i686 architecture.
I, [2011-06-29T15:33:12.549749 #816] INFO -- : Deliverables for fedora operating system plugin exists, skipping.
D, [2011-06-29T15:33:12.550825 #816] DEBUG -- : Executing platform plugin for ec2...
I, [2011-06-29T15:33:12.560869 #816] INFO -- : Converting f14-Speech appliance image to EC2 format...
T, [2011-06-29T15:33:12.561006 #816] TRACE -- : Preparing disk...
D, [2011-06-29T15:33:12.561256 #816] DEBUG -- : Executing command: 'dd if=/dev/zero of='build/appliances/i686/fedora/14/f14-Speech/ec2-plugin/tmp/f14-Speech.ec2' bs=1 count=0 seek=10240M'
D, [2011-06-29T15:33:12.583680 #816] DEBUG -- : 0+0 records in
D, [2011-06-29T15:33:12.583941 #816] DEBUG -- : 0+0 records out
D, [2011-06-29T15:33:12.584277 #816] DEBUG -- : 0 bytes (0 B) copied, 1.8539e-05 s, 0.0 kB/s
T, [2011-06-29T15:33:12.584953 #816] TRACE -- : Disk prepared
D, [2011-06-29T15:33:12.585305 #816] DEBUG -- : Preparing guestfs...
T, [2011-06-29T15:33:12.585481 #816] TRACE -- : Setting libguestfs temporary directory to '/tmp'...
T, [2011-06-29T15:33:12.587288 #816] TRACE -- : We have event callbacks available!
T, [2011-06-29T15:33:12.589506 #816] TRACE -- : Setting debug + trace...
T, [2011-06-29T15:33:12.589753 #816] TRACE -- : GFS: set_append "noapic"
T, [2011-06-29T15:33:12.589904 #816] TRACE -- : GFS: set_append = 0
T, [2011-06-29T15:33:12.590022 #816] TRACE -- : Enabling SElinux support in guestfs...
T, [2011-06-29T15:33:12.590158 #816] TRACE -- : GFS: set_selinux true
T, [2011-06-29T15:33:12.590313 #816] TRACE -- : GFS: set_selinux = 0
T, [2011-06-29T15:33:12.590426 #816] TRACE -- : Checking if HW virtualization is available...
T, [2011-06-29T15:33:12.627884 #816] TRACE -- : HW acceleration not available.
T, [2011-06-29T15:33:12.628278 #816] TRACE -- : Setting QEMU wrapper to /usr/lib/ruby/gems/1.8/gems/boxgrinder-build-0.9.2/lib/boxgrinder-build/helpers/qemu.wrapper...
T, [2011-06-29T15:33:12.628492 #816] TRACE -- : GFS: set_qemu "/usr/lib/ruby/gems/1.8/gems/boxgrinder-build-0.9.2/lib/boxgrinder-build/helpers/qemu.wrapper"
T, [2011-06-29T15:33:12.628685 #816] TRACE -- : GFS: set_qemu = 0
T, [2011-06-29T15:33:12.628802 #816] TRACE -- : QEMU wrapper set.
T, [2011-06-29T15:33:12.628929 #816] TRACE -- : Adding drive 'build/appliances/i686/fedora/14/f14-Speech/fedora-plugin/f14-Speech-sda.raw'...
T, [2011-06-29T15:33:12.629058 #816] TRACE -- : GFS: add_drive "build/appliances/i686/fedora/14/f14-Speech/fedora-plugin/f14-Speech-sda.raw"
T, [2011-06-29T15:33:12.629274 #816] TRACE -- : GFS: add_drive = 0
T, [2011-06-29T15:33:12.629378 #816] TRACE -- : Drive added.
T, [2011-06-29T15:33:12.629509 #816] TRACE -- : Adding drive 'build/appliances/i686/fedora/14/f14-Speech/ec2-plugin/tmp/f14-Speech.ec2'...
T, [2011-06-29T15:33:12.629688 #816] TRACE -- : GFS: add_drive "build/appliances/i686/fedora/14/f14-Speech/ec2-plugin/tmp/f14-Speech.ec2"
T, [2011-06-29T15:33:12.629869 #816] TRACE -- : GFS: add_drive = 0
T, [2011-06-29T15:33:12.629981 #816] TRACE -- : Drive added.
D, [2011-06-29T15:33:12.630233 #816] DEBUG -- : Enabling networking for GuestFS...
T, [2011-06-29T15:33:12.630368 #816] TRACE -- : GFS: set_network true
T, [2011-06-29T15:33:12.630491 #816] TRACE -- : GFS: set_network = 0
D, [2011-06-29T15:33:12.630947 #816] DEBUG -- : Launching guestfs...
T, [2011-06-29T15:33:12.631084 #816] TRACE -- : GFS: launch
D, [2011-06-29T15:33:12.642394 #816] DEBUG -- : GFS: [00008ms] febootstrap-supermin-helper --verbose -f checksum '/usr/lib/guestfs/supermin.d' i686
D, [2011-06-29T15:33:13.681294 #816] DEBUG -- : GFS: [01047ms] begin building supermin appliance
D, [2011-06-29T15:33:13.681829 #816] DEBUG -- : GFS: [01048ms] run febootstrap-supermin-helper
D, [2011-06-29T15:33:13.687346 #816] DEBUG -- : GFS: [01053ms] febootstrap-supermin-helper \
    --verbose \
    -f ext2 /usr/lib/guestfs/supermin.d i686 /tmp/guestfs.oefXc0/kernel /tmp/guestfs.oefXc0/initrd /tmp/guestfs.oefXc0/root
D, [2011-06-29T15:33:45.640749 #816] DEBUG -- : GFS: [33006ms] finished building supermin appliance
D, [2011-06-29T15:33:45.645834 #816] DEBUG -- : GFS: [33012ms] begin testing qemu features
D, [2011-06-29T15:33:45.904568 #816] DEBUG -- : GFS: [33270ms] finished testing qemu features
D, [2011-06-29T15:33:45.915715 #862] DEBUG -- : GFS: is_openable: /dev/kvm: No such file or directory
D, [2011-06-29T15:33:45.918845 #816] DEBUG -- : GFS: accept_from_daemon: 0x9d7f740 g->state = 1
D, [2011-06-29T15:33:45.916503 #862] DEBUG -- : GFS: [33282ms] /usr/lib/ruby/gems/1.8/gems/boxgrinder-build-0.9.2/lib/boxgrinder-build/helpers/qemu.wrapper \
    -drive file=build/appliances/i686/fedora/14/f14-Speech/fedora-plugin/f14-Speech-sda.raw,cache=off,if=virtio \
    -drive file=build/appliances/i686/fedora/14/f14-Speech/ec2-plugin/tmp/f14-Speech.ec2,cache=off,if=virtio \
    -nodefconfig \
    -nodefaults \
    -nographic \
    -m 500 \
    -no-reboot \
    -no-hpet \
    -device virtio-serial \
    -serial stdio \
    -chardev socket,path=/tmp/libguestfsh0E3ar/guestfsd.sock,id=channel0 \
    -device virtserialport,chardev=channel0,name=org.libguestfs.channel.0 \
    -netdev user,id=usernet,net=169.254.0.0/16 \
    -device virtio-net-pci,netdev=usernet \
    -kernel /tmp/.guestfs-0/kernel.816 \
    -initrd /tmp/.guestfs-0/initrd.816 \
    -append 'panic=1 console=ttyS0 udevtimeout=300 noapic acpi=off printk.time=1 cgroup_disable=memory selinux=1 enforcing=0 guestfs_verbose=1 TERM=xterm-color noapic' \
    -drive file=/tmp/.guestfs-0/root.816,snapshot=on,if=virtio,cache=unsafe
D, [2011-06-29T15:33:51.569259 #816] DEBUG -- : GFS: [    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 2.6.38.6-26.rc1.fc15.i686.PAE (mockbuild@x86-14.phx2.fedoraproject.org) (gcc version 4.6.0 20110428 (Red Ha
D, [2011-06-29T15:33:51.570776 #816] DEBUG -- : GFS: t 4.6.0-6) (GCC) ) #1 SMP Mon May 9 20:36:50 UTC 2011
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: 0000000000000000 - 000000000009f400
D, [2011-06-29T15:33:51.572235 #816] DEBUG -- : GFS: (usable)
[    0.000000] BIOS-e820: 000000000009f400 - 00000000000a0000 (reserved)
[    0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[    0.000000] BIOS-e820: 0000000000100000 - 000000001f3fd000 (usab
D, [2011-06-29T15:33:51.573715 #816] DEBUG -- : GFS: le)
[    0.000000] BIOS-e820: 000000001f3fd000 - 000000001f400000 (reserved)
[    0.000000] BIOS-e820: 00000000fffc0000 - 0000000100000000 (reserved)
[    0.000000] Using x86 segment limits to approximate NX protection
[
D, [2011-06-29T15:33:51.575154 #816] DEBUG -- : GFS:   0.000000] DMI 2.4 present.
[    0.000000] last_pfn = 0x1f3fd max_arch_pfn = 0x1000000
[    0.000000] found SMP MP-table at [c00f7b80] f7b80
[    0.000000] init_memory_mapping: 0000000000000000-000000001f3fd000
[    0.000000] RAMDIS
D, [2011-06-29T15:33:51.576635 #816] DEBUG -- : GFS: K: 1f26b000 - 1f3f0000
[    0.000000] 0MB HIGHMEM available.
[    0.000000] 499MB LOWMEM available.
[    0.000000]   mapped low ram: 0 - 1f3fd000
[    0.000000]   low ram: 0 - 1f3fd000
[    0.000000] Zone PFN ranges:
[    0.000000]
D, [2011-06-29T15:33:51.578154 #816] DEBUG -- : GFS:    DMA      0x00000010 -> 0x00001000
[    0.000000]   Normal   0x00001000 -> 0x0001f3fd
[    0.000000]   HighMem empty
[    0.000000] Movable zone start PFN for each node
[    0.000000] early_node_map[2] active
D, [2011-06-29T15:33:51.579611 #816] DEBUG -- : GFS: PFN ranges
[    0.000000]     0: 0x00000010 -> 0x0000009f
[    0.000000]     0: 0x00000100 -> 0x0001f3fd
[    0.000000] Using APIC driver default
[    0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org
[
D, [2011-06-29T15:33:51.581147 #816] DEBUG -- : GFS: 0.000000] Intel MultiProcessor Specification v1.4
[    0.000000]     Virtual Wire compatibility mode.
[    0.000000] MPTABLE: OEM ID: BOCHSCPU
[    0.000000] MPTABLE: Product ID: 0.1
[    0.000000] MPTABLE: APIC at: 0xFEE000
D, [2011-06-29T15:33:51.582596 #816] DEBUG -- : GFS: 00
[    0.000000] Processor #0 (Bootup-CPU)
[    0.000000] IOAPIC[0]: apic_id 1, version 17, address 0xfec00000, GSI 0-23
[    0.000000] Processors: 1
[    0.000000] SMP: Allowing 1 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registere
D, [2011-06-29T15:33:51.584023 #816] DEBUG -- : GFS: d nosave memory: 000000000009f000 - 00000000000a0000
[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[    0.000000] Alloca
D, [2011-06-29T15:33:51.585430 #816] DEBUG -- : GFS: ting PCI resources starting at 1f400000 (gap: 1f400000:e0bc0000)
[    0.000000] Booting paravirtualized kernel on bare hardware
[    0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:1 nr_node_ids:1
[    0
D, [2011-06-29T15:33:51.586942 #816] DEBUG -- : GFS: .000000] PERCPU: Embedded 13 pages/cpu @dec00000 s31040 r0 d22208 u2097152
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 126884
[    0.000000] Kernel command line: panic=1 console=ttyS0 udevtimeout=300 noapic acpi=off print
D, [2011-06-29T15:33:51.588363 #816] DEBUG -- : GFS: k.time=1 cgroup_disable=memory selinux=1 enforcing=0 guestfs_verbose=1 TERM=xterm-color noapic
[    0.000000] Disabling memory control group subsystem
[    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[
D, [2011-06-29T15:33:51.589726 #816] DEBUG -- : GFS:     0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Initializing CPU#0
[    0.000000] Initializing HighMem fo
D, [2011-06-29T15:33:51.591134 #816] DEBUG -- : GFS: r node 0 (00000000:00000000)
[    0.000000] Memory: 497240k/511988k available (4028k kernel code, 14296k reserved, 2570k data, 592k init, 0k highmem)
[    0.000000] virtual kernel memory layout:
[    0.000000]     fixmap : 0xff575000
D, [2011-06-29T15:33:51.592620 #816] DEBUG -- : GFS: - 0xfffff000   (10792 kB)
[    0.000000]     pkmap   : 0xff200000 - 0xff400000   (2048 kB)
[    0.000000]     vmalloc : 0xdfbfd000 - 0xff1fe000   ( 502 MB)
[    0.000000]     lowmem : 0xc0000000 - 0xdf3fd000   ( 499 MB)
[    0.000000]
D, [2011-06-29T15:33:51.593991 #816] DEBUG -- : GFS:        .init : 0xc0a72000 - 0xc0b06000   ( 592 kB)
[    0.000000]       .data : 0xc07ef342 - 0xc0a71c00   (2570 kB)
[    0.000000]       .text : 0xc0400000 - 0xc07ef342   (4028 kB)
[    0.000000] Checking if this processor honours the WP bit even in supervis
D, [2011-06-29T15:33:51.595410 #816] DEBUG -- : GFS: or mode...Ok.
[    0.000000] SLUB: Genslabs=15, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000]           RCU dyntick-idle grace-period acceleration is enabled.
[    0.00000
D, [2011-06-29T15:33:51.596905 #816] DEBUG -- : GFS: 0]           RCU-based detection of stalled CPUs is disabled.
[    0.000000] NR_IRQS:2304
[    0.000000] Console: colour dummy device 80x25
[    0.000000] console [ttyS0] enabled
D, [2011-06-29T15:33:51.617444 #816] DEBUG -- : GFS: [    0.000000] Fast TSC calibration using PIT
[    0.000000] Detected 2266.677 MHz processor.
D, [2011-06-29T15:33:51.619723 #816] DEBUG -- : GFS: [    0.005999] Calibrating delay loop (skipped), value calculated using timer frequency.. 4533.35 BogoMIPS (lpj=2266677)
[    0.006342] pid_max: defa
D, [2011-06-29T15:33:51.621142 #816] DEBUG -- : GFS: ult: 32768 minimum: 301
D, [2011-06-29T15:33:51.624330 #816] DEBUG -- : GFS: [    0.010617] Security Framework initialized
D, [2011-06-29T15:33:51.627124 #816] DEBUG -- : GFS: [    0.013395] SELinux: Initializing.
D, [2011-06-29T15:33:51.632684 #816] DEBUG -- : GFS: [    0.018792] Mount-cache hash table entries: 512
D, [2011-06-29T15:33:51.648585 #816] DEBUG -- : GFS: [    0.034427] Initializing cgroup subsys ns
[    0.035203] ns_cgroup deprecated: consider using the 'clone_children' flag without
D, [2011-06-29T15:33:51.650093 #816] DEBUG -- : GFS: the ns_cgroup.
[    0.036200] Initializing cgroup subsys cpuacct
D, [2011-06-29T15:33:51.652216 #816] DEBUG -- : GFS: [    0.038360] Initializing cgroup subsys memory
D, [2011-06-29T15:33:51.653784 #816] DEBUG -- : GFS: [    0.039530] Initializing cgroup subsys devices
[    0.040138] Initializing cgroup subsys freezer
[    0.040417] Initializing cgroup su
D, [2011-06-29T15:33:51.655280 #816] DEBUG -- : GFS: bsys net_cls
[    0.041088] Initializing cgroup subsys blkio
D, [2011-06-29T15:33:51.668782 #816] DEBUG -- : GFS: [    0.051620] SMP alternatives: switching to UP code
D, [2011-06-29T15:33:51.722918 #816] DEBUG -- : GFS: [    0.105866] Freeing SMP alternatives: 12k freed
D, [2011-06-29T15:33:51.726930 #816] DEBUG -- : GFS: [    0.109541] ftrace: allocating 23362 entries in 46 pages
D, [2011-06-29T15:33:51.789010 #816] DEBUG -- : GFS: [    0.128859] Enabling APIC mode: Flat. Using 1 I/O APICs
[    0.
D, [2011-06-29T15:33:51.790486 #816] DEBUG -- : GFS: 130173] CPU0: Intel QEMU Virtual CPU version 0.14.0 stepping 03
D, [2011-06-29T15:33:51.995831 #816] DEBUG -- : GFS: [    0.233973] Performance Events: Broken PMU hardware detected, using software events only.
D, [2011-06-29T15:33:52.012748 #816] DEBUG -- : GFS: [    0.249907] NMI watchdog disabled (cpu0): hardware events not enabled
[    0.250095] Brought up 1 CPUs
[    0.250319] Total of 1 processors activated (4533.35 BogoMIPS).
D, [2011-06-29T15:33:52.022164 #816] DEBUG -- : GFS: [    0.259545] devtmpfs: initialized
D, [2011-06-29T15:33:52.041154 #816] DEBUG -- : GFS: [    0.278637] atomic64 test passed for i586+ platform with CX8 and with SSE
[    0.279417] Time: 19:33:50 Date: 06/29/11
D, [2011-06-29T15:33:52.045327 #816] DEBUG -- : GFS: [    0.282880] NET: Registered protocol family 16
D, [2011-06-29T15:33:52.072115 #816] DEBUG -- : GFS: [    0.298041] PCI: PCI BIOS revision 2.10 entry at 0xfdf30, last bus=0
[    0.298495] PCI: Using configuration type 1 for base access
D, [2011-06-29T15:33:52.101219 #816] DEBUG -- : GFS: [    0.327711] bio: create slab <bio-0> at 0
D, [2011-06-29T15:33:52.105391 #816] DEBUG -- : GFS: [    0.331789] ACPI: Interpreter disabled.
D, [2011-06-29T15:33:52.110469 #816] DEBUG -- : GFS: [    0.337056] vgaarb: loaded
D, [2011-06-29T15:33:52.113691 #816] DEBUG -- : GFS: [    0.340012] SCSI subsystem initialized
D, [2011-06-29T15:33:52.117848 #816] DEBUG -- : GFS: [    0.344376] usbcore: registered new interface driver usbfs
[    0.345240] usbcore: registered new interfa
D, [2011-06-29T15:33:52.119186 #816] DEBUG -- : GFS: ce driver hub
[    0.346652] usbcore: registered new de
D, [2011-06-29T15:33:52.120585 #816] DEBUG -- : GFS: vice driver usb
D, [2011-06-29T15:33:52.124023 #816] DEBUG -- : GFS: [    0.350543] PCI: Probing PCI hardware
D, [2011-06-29T15:33:52.129824 #816] DEBUG -- : GFS: [    0.356363] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.356783] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB
D, [2011-06-29T15:33:52.140115 #816] DEBUG -- : GFS: [    0.366623] pci 0000:00:01.0: PIIX/ICH IRQ router [8086:7000]
D, [2011-06-29T15:33:52.149396 #816] DEBUG -- : GFS: [    0.375798] NetLabel: Initializing
[    0.376030] NetLabel: domain hash size = 128
[    0.376261] NetLabel: protocols = UNLABELED CIPSOv4
D, [2011-06-29T15:33:52.151733 #816] DEBUG -- : GFS: [    0.378371] NetLabel: unlabeled traffic allowed by default
D, [2011-06-29T15:33:52.321318 #816] DEBUG -- : GFS: [    0.547627] pnp: PnP ACPI: disabled
D, [2011-06-29T15:33:52.365203 #816] DEBUG -- : GFS: [    0.591631] NET: Registered protocol family 2
D, [2011-06-29T15:33:52.369751 #816] DEBUG -- : GFS: [    0.596266] IP route cache hash table entries: 4096 (order: 2, 16384 bytes)
D, [2011-06-29T15:33:52.376199 #816] DEBUG -- : GFS: [    0.602702] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
D, [2011-06-29T15:33:52.377650 #816] DEBUG -- : GFS: [    0.603539] TCP bind hash table entries: 16384 (order: 5, 131072 bytes)
D, [2011-06-29T15:33:52.379391 #816] DEBUG -- : GFS: [    0.605952] TCP: Hash tables configured (established 16384 bind 16384)
[    0.606537] TCP reno registered
[    0.606813] UDP hash table entries: 256 (ord
D, [2011-06-29T15:33:52.380991 #816] DEBUG -- : GFS: er: 1, 8192 bytes)
[    0.607974] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
D, [2011-06-29T15:33:52.386770 #816] DEBUG -- : GFS: [    0.613315] NET: Registered protocol family 1
[    0.613891] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
D, [2011-06-29T15:33:52.388265 #816] DEBUG -- : GFS: [    0.614510] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.615365] pci 0000:00:01.0: Activating ISA DMA hang
D, [2011-06-29T15:33:52.389697 #816] DEBUG -- : GFS: workarounds
D, [2011-06-29T15:33:52.395445 #816] DEBUG -- : GFS: [    0.622006] Trying to unpack rootfs image as initramfs...
D, [2011-06-29T15:33:52.425766 #816] DEBUG -- : GFS: [    0.652123] Freeing initrd memory: 1556k freed
D, [2011-06-29T15:33:52.433232 #816] DEBUG -- : GFS: [    0.659757] platform rtc_cmos: registered platform RTC device (no PNP device found)
D, [2011-06-29T15:33:52.439670 #816] DEBUG -- : GFS: [    0.666202] apm: BIOS version 1.2 Flags 0x03 (Driver version 1.16ac)
D, [2011-06-29T15:33:52.447616 #816] DEBUG -- : GFS: [    0.674063] audit: initializing netlink socket (disabled)
[
D, [2011-06-29T15:33:52.449052 #816] DEBUG -- : GFS: 0.675241] type=2000 audit(1309376030.673:1): initialized
D, [2011-06-29T15:33:52.530961 #816] DEBUG -- : GFS: [    0.757426] HugeTLB registered 2 MB page size, pre-allocated 0 pages
D, [2011-06-29T15:33:52.563799 #816] DEBUG -- : GFS: [    0.790245] VFS: Disk quotas dquot_6.5.2
D, [2011-06-29T15:33:52.566932 #816] DEBUG -- : GFS: [    0.793477] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
D, [2011-06-29T15:33:52.581011 #816] DEBUG -- : GFS: [    0.807529] msgmni has been set to 974
D, [2011-06-29T15:33:52.592885 #816] DEBUG -- : GFS: [    0.819433] NET: Registered protocol family 38
D, [2011-06-29T15:33:52.594679 #816] DEBUG -- : GFS: [    0.821078] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
D, [2011-06-29T15:33:52.596634 #816] DEBUG -- : GFS: [    0.823246] io scheduler noop registered
[    0.823652] io scheduler deadline registered
[    0
D, [2011-06-29T15:33:52.598033 #816] DEBUG -- : GFS: .824262] io scheduler cfq registered (default)
D, [2011-06-29T15:33:52.601561 #816] DEBUG -- : GFS: [    0.828220] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
D, [2011-06-29T15:33:52.603637 #816] DEBUG -- : GFS: [    0.830163] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[    0.830676] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
D, [2011-06-29T15:33:52.611060 #816] DEBUG -- : GFS: [    0.837563] isapnp: Scanning for PnP cards...
D, [2011-06-29T15:33:52.972090 #816] DEBUG -- : GFS: [    1.198538] isapnp: No Plug & Play device found
D, [2011-06-29T15:33:52.974670 #816] DEBUG -- : GFS: [    1.201107] virtio-pci 0000:00:02.0: found PCI INT A -> IRQ 10
[    1.201965] virtio-pci 0000:00:02.0: sharing IRQ 10 with 0000:00:06.0
D, [2011-06-29T15:33:52.977903 #816] DEBUG -- : GFS: [    1.204457] virtio-pci 0000:00:03.0: found PCI INT A -> IRQ 11
[    1.205435] virtio-pci 0
D, [2011-06-29T15:33:52.979647 #816] DEBUG -- : GFS: 000:00:04.0: found PCI INT A -> IRQ 11
D, [2011-06-29T15:33:52.981263 #816] DEBUG -- : GFS: [    1.207903] virtio-pci 0000:00:05.0: found PCI INT A -> IRQ 10
[    1.208932
D, [2011-06-29T15:33:52.982732 #816] DEBUG -- : GFS: ] virtio-pci 0000:00:06.0: found PCI INT A -> IRQ 10
[    1.209918] virtio-pci 0000:00:06.0: sharing IRQ 10 with 0000:00:02.0
D, [2011-06-29T15:33:52.986043 #816] DEBUG -- : GFS: [    1.212666] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
D, [2011-06-29T15:33:53.010318 #816] DEBUG -- : GFS: [    1.216955] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
D, [2011-06-29T15:33:53.038113 #816] DEBUG -- : GFS: [    1.244527] Non-volatile memory driver v1.3
[    1.244916] Linux agpgart interface v0.103
D, [2011-06-29T15:33:53.078177 #816] DEBUG -- : GFS: [    1.273619] brd: module loaded
D, [2011-06-29T15:33:53.090077 #816] DEBUG -- : GFS: [    1.285642] loop: module loaded
D, [2011-06-29T15:33:53.103393 #816] DEBUG -- : GFS: [    1.298915] scsi0 : ata_piix
D, [2011-06-29T15:33:53.106938 #816] DEBUG -- : GFS: [    1.302590] scsi1 : ata_piix
D, [2011-06-29T15:33:53.108604 #816] DEBUG -- : GFS: [    1.303923] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc000 irq 14
[    1.304878] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc008 irq 15
D, [2011-06-29T15:33:53.115635 #816] DEBUG -- : GFS: [    1.311269] Fixed MDIO Bus: probed
D, [2011-06-29T15:33:53.117985 #816] DEBUG -- : GFS: [    1.313448] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
D, [2011-06-29T15:33:53.119626 #816] DEBUG -- : GFS: [    1.314933] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.316085] uhci_hcd: USB Universal Host Controller Interface d
D, [2011-06-29T15:33:53.121073 #816] DEBUG -- : GFS: river
D, [2011-06-29T15:33:53.123219 #816] DEBUG -- : GFS: [    1.318876] i8042: PNP: No PS/2 controller found. Probing ports directly.
D, [2011-06-29T15:33:53.126646 #816] DEBUG -- : GFS: [    1.322272] serio: i8042 KBD port at 0x60,0x64 irq 1
[    1.322859] serio: i8042 AUX port at 0x60,0x64 irq 12
D, [2011-06-29T15:33:53.130572 #816] DEBUG -- : GFS: [    1.326209] mousedev: PS/2 mouse device common for all mice
D, [2011-06-29T15:33:53.136216 #816] DEBUG -- : GFS: [    1.331854] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
D, [2011-06-29T15:33:53.141619 #816] DEBUG -- : GFS: [    1.337213] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
[    1.338116] rtc0:
D, [2011-06-29T15:33:53.143033 #816] DEBUG -- : GFS: alarms up to one day, 114 bytes nvram
D, [2011-06-29T15:33:53.144957 #816] DEBUG -- : GFS: [    1.340673] device-mapper: uevent: version 1.0.3
D, [2011-06-29T15:33:53.150645 #816] DEBUG -- : GFS: [    1.346271] device-mapper: ioctl: 4.19.1-ioctl (2011-01-07) initialised: dm-devel@redhat.com
D, [2011-06-29T15:33:53.152699 #816] DEBUG -- : GFS: [    1.348236] cpuidle: using governor ladder
[    1.348849] cpuidle: using governor menu
D, [2011-06-29T15:33:53.157823 #816] DEBUG -- : GFS: [    1.353473] usbcore: registered new interface driver usbhid
[    1.353855] usbhid: USB HID core driver
D, [2011-06-29T15:33:53.159273 #816] DEBUG -- : GFS: [    1.354560] nf_conntrack version 0.5.0 (7793 buckets, 31172 max)
D, [2011-06-29T15:33:53.164615 #816] DEBUG -- : GFS: [    1.360285] ip_tables: (C) 2000-2006 Netfilter Core Team
D, [2011-06-29T15:33:53.167269 #816] DEBUG -- : GFS: [    1.362905] TCP cubic registered
[    1.363164] Initializing XFRM netlink socket
[    1.363552] NET: Registered protocol family 17
D, [2011-06-29T15:33:53.169138 #816] DEBUG -- : GFS: [    1.364834] Registering the dns_resolver key type
D, [2011-06-29T15:33:53.171415 #816] DEBUG -- : GFS: [    1.366648] Using IPI No-Shortcut mode
D, [2011-06-29T15:33:53.174902 #816] DEBUG -- : GFS: [    1.370583] registered taskstats version 1
[    1.371046] IMA: No TPM chip found, activating TPM-bypass!
D, [2011-06-29T15:33:53.179344 #816] DEBUG -- : GFS: [    1.375074]   Magic number: 15:225:598
D, [2011-06-29T15:33:53.181493 #816] DEBUG -- : GFS: [    1.376854] rtc_cmos rtc_cmos: setting system clock to 2011-06-29 19:33:52 UTC (1309376032)
D, [2011-06-29T15:33:53.182917 #816] DEBUG -- : GFS: [    1.378216] Initalizing network drop monitor service
D, [2011-06-29T15:33:53.269775 #816] DEBUG -- : GFS: [    1.465386] Freeing unused kernel memory: 592k freed
D, [2011-06-29T15:33:53.296154 #816] DEBUG -- : GFS: [    1.491777] Write protecting the kernel text: 4032k
D, [2011-06-29T15:33:53.298068 #816] DEBUG -- : GFS: [    1.493710] Write protecting the kernel read-only data: 1932k
D, [2011-06-29T15:33:53.339819 #816] DEBUG -- : GFS: /proc/uptime: No such file or directory
D, [2011-06-29T15:33:53.341364 #816] DEBUG -- : GFS:
D, [2011-06-29T15:33:53.345019 #816] DEBUG -- : GFS: febootstrap: ext2 mini initrd starting up
D, [2011-06-29T15:33:53.347807 #816] DEBUG -- : GFS: febootstrap: mounting /sys
D, [2011-06-29T15:33:53.358507 #816] DEBUG -- : GFS: febootstrap: insmod crc-ccitt.ko
D, [2011-06-29T15:33:53.391840 #816] DEBUG -- : GFS: febootstrap: insmod crc-itu-t.ko
D, [2011-06-29T15:33:53.412497 #816] DEBUG -- : GFS: febootstrap: insmod crc32c-intel.ko
D, [2011-06-29T15:33:53.427870 #816] DEBUG -- : GFS: insmod: error inserting 'crc32c-intel.ko': -1 No such device
D, [2011-06-29T15:33:53.431451 #816] DEBUG -- : GFS: insmod: wait: File exists
febootstrap: insmod crc7.ko
D, [2011-06-29T15:33:53.442200 #816] DEBUG -- : GFS: febootstrap: insmod ext2.ko
D, [2011-06-29T15:33:53.473828 #816] DEBUG -- : GFS: [    1.669319] Switching to clocksource tsc
D, [2011-06-29T15:33:53.505056 #816] DEBUG -- : GFS: febootstrap: insmod libcrc32c.ko
D, [2011-06-29T15:33:53.517873 #816] DEBUG -- : GFS: febootstrap: insmod rfkill.ko
D, [2011-06-29T15:33:53.525711 #816] DEBUG -- : GFS: insmod: can't read 'rfkill.ko': No such file or directory
D, [2011-06-29T15:33:53.528190 #816] DEBUG -- : GFS: insmod: wait: File exists
febootstrap: insmod scsi_transport_spi.ko
D, [2011-06-29T15:33:53.570895 #816] DEBUG -- : GFS: febootstrap: insmod virtio-rng.ko
D, [2011-06-29T15:33:53.588333 #816] DEBUG -- : GFS: [    1.783585] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input1
D, [2011-06-29T15:33:53.591701 #816] DEBUG -- : GFS: febootstrap: insmod virtio_balloon.ko
D, [2011-06-29T15:33:53.611868 #816] DEBUG -- : GFS: febootstrap: insmod virtio_blk.ko
D, [2011-06-29T15:33:53.670934 #816] DEBUG -- : GFS: [    1.866229] vda: vda1 vda2
D, [2011-06-29T15:33:53.692978 #816] DEBUG -- : GFS: [    1.888247] vdb: unknown partition table
D, [2011-06-29T15:33:53.699418 #816] DEBUG -- : GFS: [    1.894814] vdc: unknown partition table
D, [2011-06-29T15:33:53.702999 #816] DEBUG -- : GFS: febootstrap: insmod virtio_net.ko
D, [2011-06-29T15:33:53.761817 #816] DEBUG -- : GFS: febootstrap: insmod ideapad-laptop.ko
D, [2011-06-29T15:33:53.771573 #816] DEBUG -- : GFS: [    1.966844] ideapad_laptop: Unknown symbol sparse_keymap_free (err 0)
D, [2011-06-29T15:33:53.774438 #816] DEBUG -- : GFS: [    1.969978] ideapad_laptop: Unknown symbol rfkill_unregister (err 0)
D, [2011-06-29T15:33:53.777153 #816] DEBUG -- : GFS: [    1.972631] ideapad_laptop: Unknown symbol rfkill_destroy (err 0)
D, [2011-06-29T15:33:53.780638 #816] DEBUG -- : GFS: [    1.976165] ideapad_laptop: Unknown symbol rfkill_init_sw_state (err 0)
D, [2011-06-29T15:33:53.784770 #816] DEBUG -- : GFS: [    1.980307] ideapad_laptop: Unknown symbol rfkill_set_hw_state (err 0)
D, [2011-06-29T15:33:53.790242 #816] DEBUG -- : GFS: [    1.985806] ideapad_laptop: Unknown symbol rfkill_alloc (err 0)
D, [2011-06-29T15:33:53.792322 #816] DEBUG -- : GFS: [    1.987887] ideapad_laptop: Unknown symbol sparse_keymap_report_event (err 0)
D, [2011-06-29T15:33:53.794439 #816] DEBUG -- : GFS: [    1.989970] ideapad_laptop: Unknown symbol sparse_keymap_setup (err 0)
D, [2011-06-29T15:33:53.797789 #816] DEBUG -- : GFS: [    1.993301] ideapad_laptop: Unknown symbol rfkill_register (err 0)
D, [2011-06-29T15:33:53.802740 #816] DEBUG -- : GFS: insmod: error inserting 'ideapad-laptop.ko': -1 Unknown symbol in module
D, [2011-06-29T15:33:53.805580 #816] DEBUG -- : GFS: insmod: wait: File exists
febootstrap: insmod sym53c8xx.ko
D, [2011-06-29T15:33:53.857758 #816] DEBUG -- : GFS: febootstrap: picked /sys/block/vdc/dev as root device
D, [2011-06-29T15:33:53.864797 #816] DEBUG -- : GFS: febootstrap: creating /dev/root as block special 252:32
febootstrap: mounting new root on /root
D, [2011-06-29T15:33:53.876343 #816] DEBUG -- : GFS: febootstrap: chroot
D, [2011-06-29T15:33:53.881357 #816] DEBUG -- : GFS: /proc/uptime: No such file or directory
D, [2011-06-29T15:33:54.022792 #816] DEBUG -- : GFS: Starting /init script ...
D, [2011-06-29T15:33:54.153739 #816] DEBUG -- : GFS: rm: cannot remove `/proc': Is a directory
D, [2011-06-29T15:33:54.155492 #816] DEBUG -- : GFS:
D, [2011-06-29T15:33:54.200884 #816] DEBUG -- : GFS: mkdir: cannot create directory `/proc': File exists
D, [2011-06-29T15:33:54.202415 #816] DEBUG -- : GFS:
D, [2011-06-29T15:33:54.722904 #816] DEBUG -- : GFS: Starting udev:
D, [2011-06-29T15:33:54.882880 #816] DEBUG -- : GFS: udevd[59]: specified group 'dialout' unknown

D, [2011-06-29T15:33:54.890114 #816] DEBUG -- : GFS: udevd[59]: specified group 'floppy' unknown

D, [2011-06-29T15:33:54.892742 #816] DEBUG -- : GFS: udevd[59]: specified group 'cdrom' unknown

D, [2011-06-29T15:33:54.895597 #816] DEBUG -- : GFS: udevd[59]: specified group 'tape' unknown

D, [2011-06-29T15:34:02.777330 #816] DEBUG -- : GFS: [   10.972743] Clocksource tsc unstable (delta = 67687613 ns)
D, [2011-06-29T15:34:02.785113 #816] DEBUG -- : GFS: [   10.980501] Switching to clocksource jiffies
D, [2011-06-29T15:34:02.880083 #816] DEBUG -- : GFS: [   11.059536] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 0
D, [2011-06-29T15:34:03.400980 #816] DEBUG -- : GFS: [ OK
D, [2011-06-29T15:34:03.402729 #816] DEBUG -- : GFS: ]
D, [2011-06-29T15:34:03.404191 #816] DEBUG -- : GFS:
D, [2011-06-29T15:34:03.406247 #816] DEBUG -- : GFS:
D, [2011-06-29T15:34:11.905447 #816] DEBUG -- : GFS:   Reading all physical volumes. This may take a while...
D, [2011-06-29T15:34:14.610057 #816] DEBUG -- : GFS:   No volume groups found
D, [2011-06-29T15:34:14.761426 #816] DEBUG -- : GFS:   No volume groups found
D, [2011-06-29T15:34:14.998086 #816] DEBUG -- : GFS: /dev:
D, [2011-06-29T15:34:15.034493 #816] DEBUG -- : GFS: total 60
D, [2011-06-29T15:34:15.042554 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root       13 Jun 29 15:33 MAKEDEV -> /sbin/MAKEDEV
D, [2011-06-29T15:34:15.044358 #816] DEBUG -- : GFS: crw------- 1 root root 10, 134 Jun 29 15:33 apm_bios
crw------- 1 root root 10, 235 Jun 29 15:33 autofs
D, [2011-06-29T15:34:15.045813 #816] DEBUG -- : GFS: drwxr-xr-x 2 root root     4096 Jun 29 15:34 block
crw------- 1 root root 10, 234 Jun 29 15:33 btrfs-control
D, [2011-06-29T15:34:15.047320 #816] DEBUG -- : GFS: drwxr-xr-x 2 root root     4096 Jun 29 15:34 char
crw------- 1 root root   5,   1 Jun 29 15:33 console
D, [2011-06-29T15:34:15.048986 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root       11 Jun 29 15:33 core -> /proc/kcore
drwxr-xr-x 3 root root     4096 Jun 29 15:33 cpu
D, [2011-06-29T15:34:15.050471 #816] DEBUG -- : GFS: crw------- 1 root root 10, 62 Jun 29 15:33 cpu_dma_latency
drwxr-xr-x 5 root root     4096 Jun 29 15:34 disk
D, [2011-06-29T15:34:15.052199 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root       13 Jun 29 15:33 fd -> /proc/self/fd
crw-rw-rw- 1 root root   1,   7 Jun 29 15:33 full
D, [2011-06-29T15:34:15.053622 #816] DEBUG -- : GFS: crw-rw-rw- 1 root root 10, 229 Jun 29 15:33 fuse
drwxr-xr-x 3 root root     4096 Jun 29 15:34 input
D, [2011-06-29T15:34:15.066221 #816] DEBUG -- : GFS: crw------- 1 root root   1, 11 Jun 29 15:33 kmsg
brw-rw---- 1 root disk   7,
D, [2011-06-29T15:34:15.067715 #816] DEBUG -- : GFS:   0 Jun 29 15:33 loop0
brw-rw---- 1 root disk   7,   1 Jun 29 15:33 loop1
D, [2011-06-29T15:34:15.069251 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   7,   2 Jun 29 15:33 loop2
brw-rw---- 1 root disk   7,   3 Jun 29 15:33 loop3
D, [2011-06-29T15:34:15.071186 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   7,   4 Jun 29 15:33 loop4
brw-rw---- 1 root disk   7,   5 Jun 29 15:33 loop5
brw-rw---- 1 r
D, [2011-06-29T15:34:15.072586 #816] DEBUG -- : GFS: oot disk   7,   6 Jun 29 15:33 loop6
brw-rw---- 1 root disk   7,   7 Jun 29 15:33 loop7
D, [2011-06-29T15:34:15.075022 #816] DEBUG -- : GFS: drwxr-xr-x 2 422 497     4096 Jun 29 15:33 mapper
crw-r----- 1 root kmem   1,   1 Jun 29 15:33 mem
D, [2011-06-29T15:34:15.076592 #816] DEBUG -- : GFS: drwxr-xr-x 2 root root     4096 Jun 29 15:33 net
crw------- 1 root root 10, 61 Jun 29 15:33 network_latency
D, [2011-06-29T15:34:15.078566 #816] DEBUG -- : GFS: crw------- 1 root root 10, 60 Jun 29 15:33 network_throughput
crw-rw-rw- 1 root root   1,   3 Jun 29 15:33 null
D, [2011-06-29T15:34:15.080425 #816] DEBUG -- : GFS: crw-r----- 1 root kmem 10, 144 Jun 29 15:33 nvram
crw------- 1 root root   1, 12 Jun 29 15:33 oldmem
crw-r----
D, [2011-06-29T15:34:15.081828 #816] DEBUG -- : GFS: - 1 root kmem   1,   4 Jun 29 15:33 port
crw------- 1 root root 108,   0 Jun 29 15:33 ppp
D, [2011-06-29T15:34:15.083294 #816] DEBUG -- : GFS: crw-rw-rw- 1 root tty    5,   2 Jun 29 15:33 ptmx
drwxr
D, [2011-06-29T15:34:15.084637 #816] DEBUG -- : GFS: -xr-x 2 422 497     4096 Apr 24 05:36 pts
brw-rw---- 1 root disk   1,   0 Jun 29 15:33 ram0
b
D, [2011-06-29T15:34:15.086050 #816] DEBUG -- : GFS: rw-rw---- 1 root disk   1,   1 Jun 29 15:33 ram1
brw-rw---- 1 root disk   1, 10 Jun 29 15:33 ram10
D, [2011-06-29T15:34:15.087476 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   1, 11 Jun 29 15:33 ram11
brw-rw---- 1 root disk   1, 12 Jun 29 15:33 ram12
D, [2011-06-29T15:34:15.089140 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   1, 13 Jun 29 15:33 ram13
brw-rw---- 1 root disk   1, 14 Jun 29 15:33 ram14
D, [2011-06-29T15:34:15.090703 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   1, 15 Jun 29 15:33 ram15
brw-rw---- 1 root disk   1,   2 Jun 29 15:33 ram2
D, [2011-06-29T15:34:15.092143 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   1,   3 Jun 29 15:33 ram3
brw-rw---- 1 root disk   1,   4 Jun 29 15:33 ram4
D, [2011-06-29T15:34:15.093845 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   1,   5 Jun 29 15:33 ram5
brw-rw---- 1 root disk   1,   6 Jun 29 15:33 ram6
D, [2011-06-29T15:34:15.095342 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   1,   7 Jun 29 15:33 ram7
brw-rw---- 1 root disk   1,   8 Jun 29 15:34 ram8
D, [2011-06-29T15:34:15.096835 #816] DEBUG -- : GFS: brw-rw---- 1 root disk   1,   9 Jun 29 15:33 ram9
crw-rw-rw- 1 root root   1,   8 Jun 29 15:33 random
D, [2011-06-29T15:34:15.098368 #816] DEBUG -- : GFS: drwxr-xr-x 2 root root     4096 Jun 29 15:33 raw
lrwxrwxrwx 1 root root        4 Jun 29 15:33 rtc -> rtc0
D, [2011-06-29T15:34:15.099971 #816] DEBUG -- : GFS:
crw------- 1 root root 254,   0 Jun 29 15:33 rtc0
drwxr-xr-x 2 422 497     409
D, [2011-06-29T15:34:15.101408 #816] DEBUG -- : GFS: 6 Apr 24 05:36 shm
crw------- 1 root root 10, 231 Jun 29 15:33 snapshot
drwxr-xr-x 2 root root
D, [2011-06-29T15:34:15.103003 #816] DEBUG -- : GFS:      4096 Jun 29 15:33 snd
lrwxrwxrwx 1 root root       15 Jun 29 15:33 stderr -> /proc/self/fd/2
D, [2011-06-29T15:34:15.104481 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root       15 Jun 29 15:33 stdin -> /proc/self/fd/0
lrwxrwxrwx 1 root root       15 Jun 29 15:33 stdout -> /proc/self/fd/1
D, [2011-06-29T15:34:15.106225 #816] DEBUG -- : GFS: crw-rw-rw- 1 root tty    5,   0 Jun 29 15:33 tty
crw--w---- 1 root tty    4,   0 Jun 29 15:33 tty0
crw--w---- 1 roo
D, [2011-06-29T15:34:15.107656 #816] DEBUG -- : GFS: t tty    4,   1 Jun 29 15:33 tty1
crw--w---- 1 root tty    4, 10 Jun 29 15:33 tty10
crw--w-
D, [2011-06-29T15:34:15.109168 #816] DEBUG -- : GFS: --- 1 root tty    4, 11 Jun 29 15:33 tty11
crw--w---- 1 root tty    4, 12 Jun 29 15:33 tty12
D, [2011-06-29T15:34:15.110641 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 13 Jun 29 15:33 tty13
crw--w---- 1 root tty    4, 14 Jun 29 15:33 tty14
D, [2011-06-29T15:34:15.112027 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 15 Jun 29 15:33 tty15
crw--w---- 1 root tty    4, 16 Jun 29 15:33 tty16
D, [2011-06-29T15:34:15.113540 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 17 Jun 29 15:33 tty17
crw--w---- 1 root tty    4, 18 Jun 29 15:33 tty18
D, [2011-06-29T15:34:15.115146 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 19 Jun 29 15:33 tty19
crw--w---- 1 root tty    4,   2 Jun 29 15:33 tty2
crw--w--
D, [2011-06-29T15:34:15.116508 #816] DEBUG -- : GFS: -- 1 root tty    4, 20 Jun 29 15:33 tty20
crw--w---- 1 root tty    4, 21 Jun 29 15:33 tty21
cr
D, [2011-06-29T15:34:15.117951 #816] DEBUG -- : GFS: w--w---- 1 root tty    4, 22 Jun 29 15:33 tty22
crw--w---- 1 root tty    4, 23 Jun 29 15:33 tty23
D, [2011-06-29T15:34:15.119433 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 24 Jun 29 15:33 tty24
crw--w---- 1 root tty    4, 25 Jun 29 15:33 tty25
D, [2011-06-29T15:34:15.121111 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 26 Jun 29 15:33 tty26
crw--w---- 1 root tty    4, 27 Jun 29 15:33 tty27
crw--w---
D, [2011-06-29T15:34:15.122522 #816] DEBUG -- : GFS: - 1 root tty    4, 28 Jun 29 15:33 tty28
crw--w---- 1 root tty    4, 29 Jun 29 15:33 tty29
cr
D, [2011-06-29T15:34:15.123949 #816] DEBUG -- : GFS: w--w---- 1 root tty    4,   3 Jun 29 15:33 tty3
crw--w---- 1 root tty    4, 30 Jun 29 15:33 tty30
D, [2011-06-29T15:34:15.125451 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 31 Jun 29 15:33 tty31
crw--w---- 1 root tty    4, 32 Jun 29 15:34 tty32
D, [2011-06-29T15:34:15.127017 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 33 Jun 29 15:34 tty33
crw--w---- 1 root tty    4, 34 Jun 29 15:33 tty34
D, [2011-06-29T15:34:15.128645 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 35 Jun 29 15:34 tty35
crw--w---- 1 root tty    4, 36 Jun 29 15:34 tty36
D, [2011-06-29T15:34:15.130090 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 37 Jun 29 15:34 tty37
crw--w---- 1 root tty    4, 38 Jun 29 15:34 tty38
D, [2011-06-29T15:34:15.131687 #816] DEBUG -- : GFS:
crw--w---- 1 root tty    4, 39 Jun 29 15:34 tty39
crw--w---- 1 root tty    4,   4 Jun 29 15:34 tty4
D, [2011-06-29T15:34:15.133193 #816] DEBUG -- : GFS:
crw--w---- 1 root tty    4, 40 Jun 29 15:34 tty40
crw--w---- 1 root tty    4, 41 Jun 29 15:34 tty41
D, [2011-06-29T15:34:15.134979 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 42 Jun 29 15:34 tty42
crw--w---- 1 root tty    4, 43 Jun 29 15:34 tty43
crw--w-
D, [2011-06-29T15:34:15.136432 #816] DEBUG -- : GFS: --- 1 root tty    4, 44 Jun 29 15:34 tty44
crw--w---- 1 root tty    4, 45 Jun 29 15:34 tty45
D, [2011-06-29T15:34:15.138188 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 46 Jun 29 15:34 tty46
crw--w---- 1 root tty    4, 47 Jun 29 15:34 tty47
crw--w-
D, [2011-06-29T15:34:15.139580 #816] DEBUG -- : GFS: --- 1 root tty    4, 48 Jun 29 15:34 tty48
crw--w---- 1 root tty    4, 49 Jun 29 15:34 tty49
D, [2011-06-29T15:34:15.141227 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4,   5 Jun 29 15:34 tty5
crw--w---- 1 root tty    4, 50 Jun 29 15:34 tty50
crw--w--
D, [2011-06-29T15:34:15.142604 #816] DEBUG -- : GFS: -- 1 root tty    4, 51 Jun 29 15:34 tty51
crw--w---- 1 root tty    4, 52 Jun 29 15:34 tty52
cr
D, [2011-06-29T15:34:15.143932 #816] DEBUG -- : GFS: w--w---- 1 root tty    4, 53 Jun 29 15:34 tty53
crw--w---- 1 root tty    4, 54 Jun 29 15:34 tty54
D, [2011-06-29T15:34:15.145446 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 55 Jun 29 15:34 tty55
crw--w---- 1 root tty    4, 56 Jun 29 15:34 tty56
D, [2011-06-29T15:34:15.146970 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 57 Jun 29 15:34 tty57
crw--w---- 1 root tty    4, 58 Jun 29 15:34 tty58
D, [2011-06-29T15:34:15.148323 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 59 Jun 29 15:34 tty59
crw--w---- 1 root tty    4,   6 Jun 29 15:34 tty6
D, [2011-06-29T15:34:15.149787 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 60 Jun 29 15:34 tty60
crw--w---- 1 root tty    4, 61 Jun 29 15:34 tty61
D, [2011-06-29T15:34:15.151349 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4, 62 Jun 29 15:34 tty62
crw--w---- 1 root tty    4, 63 Jun 29 15:34 tty63
D, [2011-06-29T15:34:15.152786 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4,   7 Jun 29 15:34 tty7
crw--w---- 1 root tty    4,   8 Jun 29 15:34 tty8
D, [2011-06-29T15:34:15.154200 #816] DEBUG -- : GFS: crw--w---- 1 root tty    4,   9 Jun 29 15:34 tty9
crw------- 1 root root   4, 64 Jun 29 15:33 ttyS0
D, [2011-06-29T15:34:15.155600 #816] DEBUG -- : GFS: crw------- 1 root root   4, 65 Jun 29 15:33 ttyS1
crw------- 1 root root   4, 66 Jun 29 15:33 ttyS2
D, [2011-06-29T15:34:15.157112 #816] DEBUG -- : GFS: crw------- 1 root root   4, 67 Jun 29 15:33 ttyS3
crw------- 1 root root 10, 223 Jun 29 15:33 uinput
D, [2011-06-29T15:34:15.158574 #816] DEBUG -- : GFS: crw-rw-rw- 1 root root   1,   9 Jun 29 15:33 urandom
crw------- 1 root root 251,   0 Jun 29 15:34 usbmon0
D, [2011-06-29T15:34:15.160143 #816] DEBUG -- : GFS: crw-rw---- 1 root tty    7,   0 Jun 29 15:34 vcs
crw-rw---- 1 root tty    7,   1 Jun 29 15:34 vcs1
D, [2011-06-29T15:34:15.161504 #816] DEBUG -- : GFS: crw-rw---- 1 root tty    7, 128 Jun 29 15:34 vcsa
crw-rw---- 1 root tty    7, 129 Jun 29 15:34 vcsa1
D, [2011-06-29T15:34:15.163067 #816] DEBUG -- : GFS: brw-rw---- 1 root disk 252,   0 Jun 29 15:34 vda
brw-rw---- 1 root disk 252,   1 Jun 29 15:34 vda1
D, [2011-06-29T15:34:15.164425 #816] DEBUG -- : GFS: brw-rw---- 1 root disk 252,   2 Jun 29 15:34 vda2
brw-rw---- 1 root disk 252, 16 Jun 29 15:34 vdb
D, [2011-06-29T15:34:15.165925 #816] DEBUG -- : GFS: brw-rw---- 1 root disk 252, 32 Jun 29 15:34 vdc
crw------- 1 root root 10, 63 Jun 29 15:33 vga_arbiter
D, [2011-06-29T15:34:15.167357 #816] DEBUG -- : GFS: drwxr-xr-x 2 root root     4096 Jun 29 15:33 virtio-ports
crw------- 1 root root 252,   1 Jun 29 15:33 vport0p1
D, [2011-06-29T15:34:15.169120 #816] DEBUG -- : GFS: crw-rw-rw- 1 root root   1,   5 Jun 29 15:33 zero

/dev/block:
D, [2011-06-29T15:34:15.177020 #816] DEBUG -- : GFS: total 0
lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:0 -> ../ram0
lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:1 -> ../ra
D, [2011-06-29T15:34:15.178416 #816] DEBUG -- : GFS: m1
lrwxrwxrwx 1 root root 8 Jun 29 15:33 1:10 -> ../ram10
lrwxr
D, [2011-06-29T15:34:15.179924 #816] DEBUG -- : GFS: wxrwx 1 root root 8 Jun 29 15:33 1:11 -> ../ram11
lrwxrwxrwx 1 root root 8 Jun 29 15:33 1:12 -> ../ram12
D, [2011-06-29T15:34:15.181403 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 1:13 -> ../ram13
lrwxrwxrwx 1 root root 8 Jun 29 15:33 1:14 -> ../ram14
D, [2011-06-29T15:34:15.183042 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 1:15 -> ../ram15
lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:2 -> ../ram2
lr
D, [2011-06-29T15:34:15.184412 #816] DEBUG -- : GFS: wxrwxrwx 1 root root 7 Jun 29 15:33 1:3 -> ../ram3
lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:4 -> ../ram4
D, [2011-06-29T15:34:15.186080 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:5 -> ../ram5
lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:6 -> ../ram6
D, [2011-06-29T15:34:15.187476 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:7 -> ../ram7
lrwxrwxrwx 1 root root 7 Jun 29 15:34 1:8 -> ../ram8
D, [2011-06-29T15:34:15.189168 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:9 -> ../ram9
lrwxrwxrwx 1 root root 6 Jun 29 15:34 252:0 -> ../vda
lrwx
D, [2011-06-29T15:34:15.190558 #816] DEBUG -- : GFS: rwxrwx 1 root root 7 Jun 29 15:34 252:1 -> ../vda1
lrwxrwxrwx 1 root root 6 Jun 29 15:34 252:16 -> ../vdb
D, [2011-06-29T15:34:15.192249 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:34 252:2 -> ../vda2
lrwxrwxrwx 1 root root 6 Jun 29 15:34 252:32 -> ../vdc
lr
D, [2011-06-29T15:34:15.193631 #816] DEBUG -- : GFS: wxrwxrwx 1 root root 8 Jun 29 15:33 7:0 -> ../loop0
lrwxrwxrwx 1 root root 8 Jun 29 15:33 7:1 -> ../loop1
D, [2011-06-29T15:34:15.195116 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 7:2 -> ../loop2
lrwxrwxrwx 1 root root 8 Jun 29 15:33 7:3 -> ../loop3
D, [2011-06-29T15:34:15.196596 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 7:4 -> ../loop4
lrwxrwxrwx 1 root root 8 Jun 29 15:33 7:5 -> ../loop5
D, [2011-06-29T15:34:15.198066 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 7:6 -> ../loop6
lrwxrwxrwx 1 root root 8 Jun 29 15:33 7:7 -> ../loop7
D, [2011-06-29T15:34:15.200008 #816] DEBUG -- : GFS:
/dev/char:
D, [2011-06-29T15:34:15.220400 #816] DEBUG -- : GFS: total 0
lrwxrwxrwx 1 root root 11 Jun 29 15:33 10:134 -> ../apm_bios
lrwxrw
D, [2011-06-29T15:34:15.221926 #816] DEBUG -- : GFS: xrwx 1 root root 8 Jun 29 15:33 10:144 -> ../nvram
lrwxrwxrwx 1 root root 11 Jun 29 15:33 10:231 -> ../snapshot
D, [2011-06-29T15:34:15.223442 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 9 Jun 29 15:33 10:235 -> ../autofs
lrwxrwxrwx 1 root root 17 Jun 29 15:33 10:236 -> ../mapper/control
D, [2011-06-29T15:34:15.225157 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 21 Jun 29 15:33 10:60 -> ../network_throughput
lrwxrwxrwx 1 root root 18 Jun 29 15:33 10:61 -> ../network_latency
D, [2011-06-29T15:34:15.226746 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 18 Jun 29 15:33 10:62 -> ../cpu_dma_latency
lrwxrwxrwx 1 root root 14 Jun 29 15:33 10:63 -> ../vga_arbiter
D, [2011-06-29T15:34:15.228349 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 15 Jun 29 15:34 13:32 -> ../input/mouse0
lrwxrwxrwx 1 root root 13 Jun 29 15:34 13:63 -> ../input/mice
D, [2011-06-29T15:34:15.230185 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 15 Jun 29 15:34 13:64 -> ../input/event0
lrwxrwxrwx 1 root root 15 Jun 29 15:34 13:65 -> ../input/event1
D, [2011-06-29T15:34:15.231660 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 13 Jun 29 15:33 162:0 -> ../raw/rawctl
lrwxrwxrwx 1 root root 6 Jun 29 15:33 1:1 -> ../mem
D, [2011-06-29T15:34:15.233238 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:11 -> ../kmsg
lrwxrwxrwx 1 root root 9 Jun 29 15:33 1:12 -> ../oldmem
D, [2011-06-29T15:34:15.235015 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:3 -> ../null
lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:4 -> ../port
lrwxrwx
D, [2011-06-29T15:34:15.236355 #816] DEBUG -- : GFS: rwx 1 root root 7 Jun 29 15:33 1:5 -> ../zero
lrwxrwxrwx 1 root root 7 Jun 29 15:33 1:7 -> ../full
D, [2011-06-29T15:34:15.238004 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 9 Jun 29 15:33 1:8 -> ../random
lrwxrwxrwx 1 root root 10 Jun 29 15:33 1:9 -> ../urandom
D, [2011-06-29T15:34:15.239430 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 12 Jun 29 15:33 202:0 -> ../cpu/0/msr
lrwxrwxrwx 1 root root 14 Jun 29 15:33 203:0 -> ../cpu/0/cpuid
D, [2011-06-29T15:34:15.241143 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 10 Jun 29 15:34 251:0 -> ../usbmon0
lrwxrwxrwx 1 root root 11 Jun 29 15:33 252:1 -> ../vport0p1
D, [2011-06-29T15:34:15.242652 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:33 254:0 -> ../rtc0
lrwxrwxrwx 1 root root 7 Jun 29 15:33 4:0 -> ../tty0
D, [2011-06-29T15:34:15.244220 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:33 4:1 -> ../tty1
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:10 -> ../tty10
D, [2011-06-29T15:34:15.245777 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:11 -> ../tty11
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:12 -> ../tty12
D, [2011-06-29T15:34:15.247292 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:13 -> ../tty13
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:14 -> ../tty14
D, [2011-06-29T15:34:15.248922 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:15 -> ../tty15
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:16 -> ../tty16
lrwxr
D, [2011-06-29T15:34:15.250351 #816] DEBUG -- : GFS: wxrwx 1 root root 8 Jun 29 15:33 4:17 -> ../tty17
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:18 -> ../tty18
D, [2011-06-29T15:34:15.251994 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:19 -> ../tty19
lrwxrwxrwx 1 root root 7 Jun 29 15:33 4:2 -> ../tty2
lrwxrwxr
D, [2011-06-29T15:34:15.253348 #816] DEBUG -- : GFS: wx 1 root root 8 Jun 29 15:33 4:20 -> ../tty20
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:21 -> ../tty21
D, [2011-06-29T15:34:15.254932 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:22 -> ../tty22
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:23 -> ../tty23
D, [2011-06-29T15:34:15.256337 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:24 -> ../tty24
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:25 -> ../tty25
D, [2011-06-29T15:34:15.257907 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:26 -> ../tty26
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:27 -> ../tty27
D, [2011-06-29T15:34:15.259309 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:28 -> ../tty28
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:29 -> ../tty29
D, [2011-06-29T15:34:15.260873 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:33 4:3 -> ../tty3
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:30 -> ../tty30
D, [2011-06-29T15:34:15.262269 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:31 -> ../tty31
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:32 -> ../tty32
D, [2011-06-29T15:34:15.263656 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:33 -> ../tty33
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:34 -> ../tty34
D, [2011-06-29T15:34:15.265187 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:35 -> ../tty35
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:36 -> ../tty36
D, [2011-06-29T15:34:15.266620 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:37 -> ../tty37
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:38 -> ../tty38
D, [2011-06-29T15:34:15.268223 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:39 -> ../tty39
lrwxrwxrwx 1 root root 7 Jun 29 15:34 4:4 -> ../tty4
D, [2011-06-29T15:34:15.269618 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:40 -> ../tty40
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:41 -> ../tty41
D, [2011-06-29T15:34:15.271174 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:42 -> ../tty42
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:43 -> ../tty43
D, [2011-06-29T15:34:15.272904 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:44 -> ../tty44
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:45 -> ../tty45
D, [2011-06-29T15:34:15.274268 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:46 -> ../tty46
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:47 -> ../tty47
D, [2011-06-29T15:34:15.275753 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:48 -> ../tty48
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:49 -> ../tty49
D, [2011-06-29T15:34:15.277251 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:34 4:5 -> ../tty5
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:50 -> ../tty50
D, [2011-06-29T15:34:15.278903 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:51 -> ../tty51
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:52 -> ../tty52
D, [2011-06-29T15:34:15.280314 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:53 -> ../tty53
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:54 -> ../tty54
D, [2011-06-29T15:34:15.282089 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:55 -> ../tty55
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:56 -> ../tty56
lrwxrwxrwx
D, [2011-06-29T15:34:15.283470 #816] DEBUG -- : GFS: 1 root root 8 Jun 29 15:34 4:57 -> ../tty57
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:58 -> ../tty58
D, [2011-06-29T15:34:15.285086 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:59 -> ../tty59
lrwxrwxrwx 1 root root 7 Jun 29 15:34 4:6 -> ../tty6
lr
D, [2011-06-29T15:34:15.286411 #816] DEBUG -- : GFS: wxrwxrwx 1 root root 8 Jun 29 15:34 4:60 -> ../tty60
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:61 -> ../tty61
D, [2011-06-29T15:34:15.288047 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:62 -> ../tty62
lrwxrwxrwx 1 root root 8 Jun 29 15:34 4:63 -> ../tty63
D, [2011-06-29T15:34:15.289396 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:64 -> ../ttyS0
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:65 -> ../ttyS1
D, [2011-06-29T15:34:15.291017 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:66 -> ../ttyS2
lrwxrwxrwx 1 root root 8 Jun 29 15:33 4:67 -> ../ttyS3
D, [2011-06-29T15:34:15.292424 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:34 4:7 -> ../tty7
lrwxrwxrwx 1 root root 7 Jun 29 15:34 4:8 -> ../tty8
D, [2011-06-29T15:34:15.294044 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:34 4:9 -> ../tty9
lrwxrwxrwx 1 root root 6 Jun 29 15:33 5:0 -> ../tty
lr
D, [2011-06-29T15:34:15.295390 #816] DEBUG -- : GFS: wxrwxrwx 1 root root 10 Jun 29 15:33 5:1 -> ../console
lrwxrwxrwx 1 root root 7 Jun 29 15:33 5:2 -> ../ptmx
D, [2011-06-29T15:34:15.297005 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 6 Jun 29 15:34 7:0 -> ../vcs
lrwxrwxrwx 1 root root 7 Jun 29 15:34 7:1 -> ../vcs1
D, [2011-06-29T15:34:15.298507 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 7 Jun 29 15:34 7:128 -> ../vcsa
lrwxrwxrwx 1 root root 8 Jun 29 15:34 7:129 -> ../vcsa1
D, [2011-06-29T15:34:15.300313 #816] DEBUG -- : GFS:
/dev/cpu:
D, [2011-06-29T15:34:15.302096 #816] DEBUG -- : GFS: total 4
drwxr-xr-x 2 root root    4096 Jun 29 15:33 0
crw------- 1 root root 10, 184 Jun 29 15:33 microcode
D, [2011-06-29T15:34:15.303502 #816] DEBUG -- : GFS:

/dev/cpu/0:
D, [2011-06-29T15:34:15.305282 #816] DEBUG -- : GFS: total 0
cr--r--r-- 1 root root 203, 0 Jun 29 15:33 cpuid
crw------- 1 root root 202, 0 Jun 29 15:33 msr
D, [2011-06-29T15:34:15.306613 #816] DEBUG -- : GFS:

/dev/disk:
D, [2011-06-29T15:34:15.308432 #816] DEBUG -- : GFS: total 12
drwxr-xr-x 2 root root 4096 Jun 29 15:34 by-label
drwxr-xr-x 2 root root 4096
D, [2011-06-29T15:34:15.310015 #816] DEBUG -- : GFS: Jun 29 15:34 by-path
drwxr-xr-x 2 root root 4096 Jun 29 15:34 by-uuid

/dev/dis
D, [2011-06-29T15:34:15.311355 #816] DEBUG -- : GFS: k/by-label:
t
D, [2011-06-29T15:34:15.312745 #816] DEBUG -- : GFS: otal 0
lrwxrwxrwx 1 root root 10 Jun 29 15:34 79d3d2d4 -> ../../vda1
lrwxrwxrwx 1 root ro
D, [2011-06-29T15:34:15.314125 #816] DEBUG -- : GFS: ot 10 Jun 29 15:34 d8863c17 -> ../../vda2

/dev/disk/by-path:
D, [2011-06-29T15:34:15.317073 #816] DEBUG -- : GFS: total 0
lrwxrwxrwx 1 root root 9 Jun 29 15:34 pci-0000:00:04.0-virtio-pci-virtio2 -> ../../vda
lrwxrwxrwx 1 ro
D, [2011-06-29T15:34:15.318478 #816] DEBUG -- : GFS: ot root 10 Jun 29 15:34 pci-0000:00:04.0-virtio-pci-virtio2-part1 -> ../../vda1
lrwxrwxrwx 1 root root 10 Jun 29 15:34 pci-0000:00:04.0
D, [2011-06-29T15:34:15.320008 #816] DEBUG -- : GFS: -virtio-pci-virtio2-part2 -> ../../vda2
lrwxrwxrwx 1 root root 9 Jun 29 15:34 pci-0000:00:05.0-virtio-pci-virtio3 -> ../../vdb
D, [2011-06-29T15:34:15.321481 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 9 Jun 29 15:34 pci-0000:00:06.0-virtio-pci-virtio4 -> ../../vdc

/dev/disk/by-uui
D, [2011-06-29T15:34:15.323081 #816] DEBUG -- : GFS: d:
D, [2011-06-29T15:34:15.324573 #816] DEBUG -- : GFS: total 0
lrwxrwxrwx 1 root root 10 Jun 29 15:34 61f43e3f-8860-4f72-a73f-6ab2fa73d0ab -> ../../vda2
D, [2011-06-29T15:34:15.326236 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 9 Jun 29 15:34 b9ba6a3e-3b23-4510-b08e-552661a93da7 -> ../../vdc
lrwxrwxrwx 1 root root 10 Jun 29 15:34 ba254e2b-bc04-45fb-ab7a-e6cab5513050 -> ../
D, [2011-06-29T15:34:15.327578 #816] DEBUG -- : GFS: ../vda1

/dev/input:
D, [2011-06-29T15:34:15.330180 #816] DEBUG -- : GFS: total 4
drwxr-xr-x 2 root root   4096 Jun 29 15:34 by-path
crw-r----- 1 root root 13, 64 Jun 29 15:
D, [2011-06-29T15:34:15.331520 #816] DEBUG -- : GFS: 34 event0
crw-r----- 1 root root 13, 65 Jun 29 15:34 event1
D, [2011-06-29T15:34:15.333204 #816] DEBUG -- : GFS: crw-r----- 1 root root 13, 63 Jun 29 15:34 mice
crw-r----- 1 root root 13, 32 Jun 29 15:34 mouse0

D, [2011-06-29T15:34:15.334732 #816] DEBUG -- : GFS: /dev/input/by-path:
D, [2011-06-29T15:34:15.336538 #816] DEBUG -- : GFS: total 0
lrwxrwxrwx 1 root root 9 Jun 29 15:34 platform-i8042-serio-0-event-kbd -> ../event0
D, [2011-06-29T15:34:15.338317 #816] DEBUG -- : GFS: lrwxrwxrwx 1 root root 9 Jun 29 15:34 platform-i8042-serio-1-event-mouse -> ../event1
lrwxrwxrwx 1 root root 9 Jun 29 15:34 platform-i8042-serio-1-mouse -> ../mouse0
D, [2011-06-29T15:34:15.340166 #816] DEBUG -- : GFS:
/dev/mapper:
total 0
crw------- 1
D, [2011-06-29T15:34:15.341690 #816] DEBUG -- : GFS: root root 10, 236 Jun 29 15:33 control

/dev/net:
D, [2011-06-29T15:34:15.343488 #816] DEBUG -- : GFS: total 0
crw-rw-rw- 1 root root 10, 200 Jun 29 15:33 tun

/d
D, [2011-06-29T15:34:15.344955 #816] DEBUG -- : GFS: ev/pts:
total 0

/de
D, [2011-06-29T15:34:15.346311 #816] DEBUG -- : GFS: v/raw:
total 0
crw-rw---- 1
D, [2011-06-29T15:34:15.347702 #816] DEBUG -- : GFS: root disk 162, 0 Jun 29 15:33 rawctl

/dev/shm:
total 0
D, [2011-06-29T15:34:15.349168 #816] DEBUG -- : GFS:

/dev/snd:
D, [2011-06-29T15:34:15.350586 #816] DEBUG -- : GFS: total 0
crw------- 1 root root 116, 1 Jun 29 15:33 seq
crw------- 1 root root 116, 33
D, [2011-06-29T15:34:15.351971 #816] DEBUG -- : GFS: Jun 29 15:33 timer

/dev/virtio-ports:
D, [2011-06-29T15:34:15.353622 #816] DEBUG -- : GFS: total 0
lrwxrwxrwx 1 root root 11 Jun 29 15:33 org.libguestfs.channel.0 -> ../vport0p1
D, [2011-06-29T15:34:15.414665 #816] DEBUG -- : GFS: rootfs / rootfs rw 0 0
/dev/root / ext2 rw,noatime,errors=continue 0 0
/proc /proc proc rw,relatime 0 0
/sys /sys sysfs rw,relatime 0 0
D, [2011-06-29T15:34:15.416128 #816] DEBUG -- : GFS:
none /selinux selinuxfs rw,relatime 0 0
D, [2011-06-29T15:34:15.746776 #816] DEBUG -- : GFS:   No volume groups found
D, [2011-06-29T15:34:15.748296 #816] DEBUG -- : GFS:
D, [2011-06-29T15:34:15.919476 #816] DEBUG -- : GFS:   No volume groups found
D, [2011-06-29T15:34:16.020418 #816] DEBUG -- : GFS: eth0      Link encap:Ethernet HWaddr 52:54:00:12:34:56
D, [2011-06-29T15:34:16.022957 #816] DEBUG -- : GFS:           inet addr:169.254.2.10 Bcast:169.254.255.255 Mask:255.255.0.0
D, [2011-06-29T15:34:16.025111 #816] DEBUG -- : GFS:           UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
          RX packets:0 errors:0 dropped:0 o
D, [2011-06-29T15:34:16.026425 #816] DEBUG -- : GFS: verruns:0 frame:0
          TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
D, [2011-06-29T15:34:16.028183 #816] DEBUG -- : GFS:           collisions:0 txqueuelen:1000
          RX bytes:0 (0.0 b) TX bytes:0 (0.0 b)

D, [2011-06-29T15:34:16.031258 #816] DEBUG -- : GFS: lo        Link encap:Local Loopback
          inet addr:127.0.0.1 Mask:255.0.0.0
D, [2011-06-29T15:34:16.033017 #816] DEBUG -- : GFS:           UP LOOPBACK RUNNING MTU:16436 Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:0 errors:0 dropped:0 over
D, [2011-06-29T15:34:16.034350 #816] DEBUG -- : GFS: runs:0 carrier:0
          collisions:0 txqueuelen:0
          RX bytes:0 (0.0 b) TX bytes:0 (0.0 b)
D, [2011-06-29T15:34:16.035970 #816] DEBUG -- : GFS:
D, [2011-06-29T15:34:16.129059 #816] DEBUG -- : GFS: Kernel IP routing table
D, [2011-06-29T15:34:16.130667 #816] DEBUG -- : GFS: Destination     Gateway         Genmask         Flags   MSS Window irtt Iface
D, [2011-06-29T15:34:16.143452 #816] DEBUG -- : GFS: 169.254.0.0     0.0.0.0         255.255.0.0     U         0 0          0 eth0
0.0.0.0         169.254.2.2     0.0.0.0         UG        0 0          0 eth0
D, [2011-06-29T15:34:16.145166 #816] DEBUG -- : GFS:
D, [2011-06-29T15:34:16.212162 #816] DEBUG -- : GFS: Module                  Size Used by
D, [2011-06-29T15:34:16.219963 #816] DEBUG -- : GFS: i2c_piix4               9270 0
D, [2011-06-29T15:34:16.223370 #816] DEBUG -- : GFS: i2c_core               21344 1 i2c_piix4
D, [2011-06-29T15:34:16.226421 #816] DEBUG -- : GFS: sym53c8xx              59715 0
D, [2011-06-29T15:34:16.230754 #816] DEBUG -- : GFS:
virtio_net             10627 0
virtio_blk              4067 1
D, [2011-06-29T15:34:16.232236 #816] DEBUG -- : GFS: virtio_balloon          3499 0
virtio_rng              1582 0
scsi_transport_spi     17542
D, [2011-06-29T15:34:16.233633 #816] DEBUG -- : GFS: 1 sym53c8xx
libcrc32c                818 0
D, [2011-06-29T15:34:16.234998 #816] DEBUG -- : GFS:
ext2                   50364 1
crc7                     993 0
D, [2011-06-29T15:34:16.236385 #816] DEBUG -- : GFS:
crc_itu_t               1251 0
crc_ccitt               1253 0
D, [2011-06-29T15:34:16.428167 #816] DEBUG -- : GFS: Wed Jun 29 15:34:05 EDT 2011
D, [2011-06-29T15:34:16.440091 #816] DEBUG -- : GFS: uptime:
D, [2011-06-29T15:34:16.513095 #816] DEBUG -- : GFS: 14.74 0.60
D, [2011-06-29T15:34:16.705092 #816] DEBUG -- : GFS: verbose daemon enabled
D, [2011-06-29T15:34:16.709021 #816] DEBUG -- : GFS: linux commmand line: panic=1 console=ttyS0 udevtimeout=300 noapic acpi=off printk.time=1 cgroup_disable=memory selinux=1 enforcing=0 guestfs_verbose=1 TERM
=xterm-color noapic

D, [2011-06-29T15:34:16.717577 #816] DEBUG -- : GFS: recv_from_daemon: received GUESTFS_LAUNCH_FLAG
D, [2011-06-29T15:34:16.717802 #816] DEBUG -- : GFS: [64084ms] appliance is up
T, [2011-06-29T15:34:16.717994 #816] TRACE -- : GFS: launch = 0
T, [2011-06-29T15:34:16.718118 #816] TRACE -- : Guestfs launched.
T, [2011-06-29T15:34:16.720489 #816] TRACE -- : GFS: list_devices
D, [2011-06-29T15:34:16.722423 #816] DEBUG -- : GFS: send_to_daemon: 44 bytes: 00 00 00 28 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 07 | 00 00 00 00 | ...
D, [2011-06-29T15:34:16.726131 #816] DEBUG -- : GFS: guestfsd: main_loop: new request, len 0x28
D, [2011-06-29T15:34:16.733848 #816] DEBUG -- : GFS: recv_from_daemon: 68 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 07 | 00 00 00 01 | 00 12 34 00 | ...
T, [2011-06-29T15:34:16.734033 #816] TRACE -- : GFS: list_devices = ["/dev/vda", "/dev/vdb"]
T, [2011-06-29T15:34:16.734209 #816] TRACE -- : GFS: list_partitions
D, [2011-06-29T15:34:16.734696 #816] DEBUG -- : GFS: send_to_daemon: 44 bytes: 00 00 00 28 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 00 | ...
D, [2011-06-29T15:34:16.737699 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 7 (list_devices) took 0.00 seconds
guestfsd: main_loop: new request, len 0x28
D, [2011-06-29T15:34:16.751218 #816] DEBUG -- : GFS: recv_from_daemon: 76 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 01 | 00 12 34 01 | ...
T, [2011-06-29T15:34:16.751408 #816] TRACE -- : GFS: list_partitions = ["/dev/vda1", "/dev/vda2"]
D, [2011-06-29T15:34:16.751923 #816] DEBUG -- : Loading SELinux policy to sync filesystem...
T, [2011-06-29T15:34:16.752075 #816] TRACE -- : Mounting partitions...
T, [2011-06-29T15:34:16.752371 #816] TRACE -- : GFS: list_partitions
D, [2011-06-29T15:34:16.752841 #816] DEBUG -- : GFS: send_to_daemon: 44 bytes: 00 00 00 28 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 00 | ...
D, [2011-06-29T15:34:16.757872 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 8 (list_partitions) took 0.01 seconds
D, [2011-06-29T15:34:16.759696 #816] DEBUG -- : GFS: guestfsd: main_loop: new request, len 0x28
D, [2011-06-29T15:34:16.762330 #816] DEBUG -- : GFS: recv_from_daemon: 76 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 01 | 00 12 34 02 | ...
T, [2011-06-29T15:34:16.762507 #816] TRACE -- : GFS: list_partitions = ["/dev/vda1", "/dev/vda2"]
T, [2011-06-29T15:34:16.762985 #816] TRACE -- : Mounting /dev/vda1 partition to /...
T, [2011-06-29T15:34:16.764320 #816] TRACE -- : GFS: mount_options "" "/dev/vda1" "/"
D, [2011-06-29T15:34:16.764704 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 00 | ...
D, [2011-06-29T15:34:16.766055 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 8 (list_partitions) took 0.00 seconds
D, [2011-06-29T15:34:16.768064 #816] DEBUG -- : GFS: guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:34:16.774583 #816] DEBUG -- : GFS: mount -o /dev/vda1 /sysroot/
D, [2011-06-29T15:34:17.170148 #816] DEBUG -- : GFS: [   15.392125] EXT4-fs (vda1): recovery complete
D, [2011-06-29T15:34:17.180964 #816] DEBUG -- : GFS: [   15.402884] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
D, [2011-06-29T15:34:17.217140 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 01 | 00 12 34 03 | ...
T, [2011-06-29T15:34:17.217307 #816] TRACE -- : GFS: mount_options = 0
T, [2011-06-29T15:34:17.218255 #816] TRACE -- : GFS: set_e2label "/dev/vda1" "79d3d2d4"
D, [2011-06-29T15:34:17.218579 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...
D, [2011-06-29T15:34:17.220725 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 74 (mount_options) took 0.43 seconds
guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:34:17.225880 #816] DEBUG -- : GFS: e2label /dev/vda1 79d3d2d4
D, [2011-06-29T15:34:17.424647 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 04 | ...
T, [2011-06-29T15:34:17.424948 #816] TRACE -- : GFS: set_e2label = 0
T, [2011-06-29T15:34:17.425085 #816] TRACE -- : Partition mounted.
T, [2011-06-29T15:34:17.425241 #816] TRACE -- : Mounting /dev/vda2 partition to /SpeechMagic...
T, [2011-06-29T15:34:17.425399 #816] TRACE -- : GFS: mount_options "" "/dev/vda2" "/SpeechMagic"
D, [2011-06-29T15:34:17.425935 #816] DEBUG -- : GFS: send_to_daemon: 80 bytes: 00 00 00 4c | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 00 | ...
D, [2011-06-29T15:34:17.428021 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.20 seconds
guestfsd: main_loop: new request, len 0x4c
D, [2011-06-29T15:34:17.446082 #816] DEBUG -- : GFS: mount -o /dev/vda2 /sysroot/SpeechMagic
D, [2011-06-29T15:34:17.725789 #816] DEBUG -- : GFS: [   15.946757] EXT4-fs (vda2): recovery complete
[   15.947095] EXT4-fs (vda2): mounted filesystem with ordered data mode. Opts: (null)
D, [2011-06-29T15:34:17.801089 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 01 | 00 12 34 05 | ...
T, [2011-06-29T15:34:17.801252 #816] TRACE -- : GFS: mount_options = 0
T, [2011-06-29T15:34:17.802446 #816] TRACE -- : GFS: set_e2label "/dev/vda2" "d8863c17"
D, [2011-06-29T15:34:17.802854 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...
D, [2011-06-29T15:34:17.805578 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 74 (mount_options) took 0.37 seconds
D, [2011-06-29T15:34:17.807020 #816] DEBUG -- : GFS:
D, [2011-06-29T15:34:17.809864 #816] DEBUG -- : GFS: guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:34:17.814698 #816] DEBUG -- : GFS: e2label /dev/vda2 d8863c17
D, [2011-06-29T15:34:18.011111 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 06 | ...
T, [2011-06-29T15:34:18.011292 #816] TRACE -- : GFS: set_e2label = 0
T, [2011-06-29T15:34:18.011422 #816] TRACE -- : Partition mounted.
T, [2011-06-29T15:34:18.011770 #816] TRACE -- : GFS: exists "/etc/sysconfig/selinux"
D, [2011-06-29T15:34:18.012112 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 24 | 00 00 00 00 | ...
D, [2011-06-29T15:34:18.014135 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.20 seconds
guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:34:18.137694 #816] DEBUG -- : GFS: recv_from_daemon: 44 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 24 | 00 00 00 01 | 00 12 34 07 | ...
T, [2011-06-29T15:34:18.137878 #816] TRACE -- : GFS: exists = 1
T, [2011-06-29T15:34:18.138017 #816] TRACE -- : Loading SElinux policy...
T, [2011-06-29T15:34:18.138200 #816] TRACE -- : GFS: aug_init "/" 32
D, [2011-06-29T15:34:18.138499 #816] DEBUG -- : GFS: send_to_daemon: 56 bytes: 00 00 00 34 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 10 | 00 00 00 00 | ...
D, [2011-06-29T15:34:18.140620 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 36 (exists) took 0.10 seconds
guestfsd: main_loop: new request, len 0x34
D, [2011-06-29T15:34:44.566798 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 10 | 00 00 00 01 | 00 12 34 08 | ...
T, [2011-06-29T15:34:44.566970 #816] TRACE -- : GFS: aug_init = 0
T, [2011-06-29T15:34:44.567133 #816] TRACE -- : GFS: aug_rm "/augeas/load//incl[. != '/etc/sysconfig/selinux']"
D, [2011-06-29T15:34:44.567436 #816] DEBUG -- : GFS: send_to_daemon: 100 bytes: 00 00 00 60 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 16 | 00 00 00 00 | ...
D, [2011-06-29T15:34:44.569860 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 16 (aug_init) took 4.77 seconds
guestfsd: main_loop: new request, len 0x60
D, [2011-06-29T15:34:44.577648 #816] DEBUG -- : GFS: recv_from_daemon: 44 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 16 | 00 00 00 01 | 00 12 34 09 | ...
T, [2011-06-29T15:34:44.577785 #816] TRACE -- : GFS: aug_rm = 0
T, [2011-06-29T15:34:44.578021 #816] TRACE -- : GFS: aug_load
D, [2011-06-29T15:34:44.578329 #816] DEBUG -- : GFS: send_to_daemon: 44 bytes: 00 00 00 28 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 1b | 00 00 00 00 | ...
D, [2011-06-29T15:34:44.580238 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 22 (aug_rm) took 0.00 seconds
guestfsd: main_loop: new request, len 0x28
D, [2011-06-29T15:35:06.773650 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 1b | 00 00 00 01 | 00 12 34 0a | ...
T, [2011-06-29T15:35:06.773820 #816] TRACE -- : GFS: aug_load = 0
T, [2011-06-29T15:35:06.774078 #816] TRACE -- : GFS: aug_get "/files/etc/sysconfig/selinux/SELINUX"
D, [2011-06-29T15:35:06.774369 #816] DEBUG -- : GFS: send_to_daemon: 84 bytes: 00 00 00 50 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 13 | 00 00 00 00 | ...
D, [2011-06-29T15:35:06.776518 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 27 (aug_load) took 11.22 seconds
guestfsd: main_loop: new request, len 0x50
D, [2011-06-29T15:35:06.777794 #816] DEBUG -- : GFS: recv_from_daemon: 56 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 13 | 00 00 00 01 | 00 12 34 0b | ...
T, [2011-06-29T15:35:06.777994 #816] TRACE -- : GFS: aug_get = "permissive"
T, [2011-06-29T15:35:06.778166 #816] TRACE -- : GFS: sh "/usr/sbin/load_policy"
D, [2011-06-29T15:35:06.778484 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 6f | 00 00 00 00 | ...
D, [2011-06-29T15:35:06.780285 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 19 (aug_get) took 0.00 seconds
guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:35:06.784017 #816] DEBUG -- : GFS: mount --bind /dev /sysroot/dev
D, [2011-06-29T15:35:06.905296 #816] DEBUG -- : GFS: mount --bind /dev/pts /sysroot/dev/pts
D, [2011-06-29T15:35:07.003493 #816] DEBUG -- : GFS: mount --bind /proc /sysroot/proc
D, [2011-06-29T15:35:07.155966 #816] DEBUG -- : GFS: mount --bind /selinux /sysroot/selinux
D, [2011-06-29T15:35:07.307261 #816] DEBUG -- : GFS: mount --bind /sys /sysroot/sys
D, [2011-06-29T15:35:07.456231 #816] DEBUG -- : GFS: /bin/sh -c /usr/sbin/load_policy
D, [2011-06-29T15:35:29.105041 #816] DEBUG -- : GFS: [   36.983021] SELinux: Permission read_policy in class security not defined in policy.
D, [2011-06-29T15:35:29.108346 #816] DEBUG -- : GFS: [   36.986179] SELinux: Permission syslog in class capability2 not defined in policy.
[   36.986322] SELinux: the above unknown classes and permissions will be allowed
D, [2011-06-29T15:35:29.179090 #816] DEBUG -- : GFS: [   37.057006] type=1403 audit(1309376067.857:2): policy loaded auid=4294967295 ses=4294967295
D, [2011-06-29T15:35:29.219377 #816] DEBUG -- : GFS: umount /sysroot/sys
D, [2011-06-29T15:35:29.374630 #816] DEBUG -- : GFS: umount /sysroot/selinux
D, [2011-06-29T15:35:29.525355 #816] DEBUG -- : GFS: umount /sysroot/proc
D, [2011-06-29T15:35:29.671276 #816] DEBUG -- : GFS: umount /sysroot/dev/pts
D, [2011-06-29T15:35:29.810361 #816] DEBUG -- : GFS: umount /sysroot/dev
D, [2011-06-29T15:35:29.950734 #816] DEBUG -- : GFS: recv_from_daemon: 44 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 6f | 00 00 00 01 | 00 12 34 0c | ...
T, [2011-06-29T15:35:29.950945 #816] TRACE -- : GFS: sh = ""
T, [2011-06-29T15:35:29.951076 #816] TRACE -- : SElinux policy loaded.
T, [2011-06-29T15:35:29.951234 #816] TRACE -- : GFS: aug_close
D, [2011-06-29T15:35:29.951511 #816] DEBUG -- : GFS: send_to_daemon: 44 bytes: 00 00 00 28 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 1a | 00 00 00 00 | ...
D, [2011-06-29T15:35:29.953593 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 111 (sh) took 5.47 seconds
guestfsd: main_loop: new request, len 0x28
D, [2011-06-29T15:35:30.279176 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 1a | 00 00 00 01 | 00 12 34 0d | ...
T, [2011-06-29T15:35:30.279358 #816] TRACE -- : GFS: aug_close = 0
T, [2011-06-29T15:35:30.279512 #816] TRACE -- : GFS: list_partitions
D, [2011-06-29T15:35:30.280024 #816] DEBUG -- : GFS: send_to_daemon: 44 bytes: 00 00 00 28 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 00 | ...
D, [2011-06-29T15:35:30.282037 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 26 (aug_close) took 0.31 seconds
guestfsd: main_loop: new request, len 0x28
D, [2011-06-29T15:35:30.289422 #816] DEBUG -- : GFS: recv_from_daemon: 76 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 01 | 00 12 34 0e | ...
T, [2011-06-29T15:35:30.289746 #816] TRACE -- : GFS: list_partitions = ["/dev/vda1", "/dev/vda2"]
T, [2011-06-29T15:35:30.290015 #816] TRACE -- : Unmounting partitions...
T, [2011-06-29T15:35:30.290128 #816] TRACE -- : Unmounting partition /dev/vda2...
T, [2011-06-29T15:35:30.290314 #816] TRACE -- : GFS: umount "/dev/vda2"
D, [2011-06-29T15:35:30.290630 #816] DEBUG -- : GFS: send_to_daemon: 60 bytes: 00 00 00 38 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 2d | 00 00 00 00 | ...
D, [2011-06-29T15:35:30.292458 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 8 (list_partitions) took 0.00 seconds
guestfsd: main_loop: new request, len 0x38
D, [2011-06-29T15:35:30.294876 #816] DEBUG -- : GFS: umount /dev/vda2
D, [2011-06-29T15:35:30.467352 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 2d | 00 00 00 01 | 00 12 34 0f | ...
T, [2011-06-29T15:35:30.467753 #816] TRACE -- : GFS: umount = 0
T, [2011-06-29T15:35:30.467876 #816] TRACE -- : Partition unmounted.
T, [2011-06-29T15:35:30.468014 #816] TRACE -- : Unmounting partition /dev/vda1...
T, [2011-06-29T15:35:30.468159 #816] TRACE -- : GFS: umount "/dev/vda1"
D, [2011-06-29T15:35:30.468448 #816] DEBUG -- : GFS: send_to_daemon: 60 bytes: 00 00 00 38 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 2d | 00 00 00 00 | ...
D, [2011-06-29T15:35:30.470479 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 45 (umount) took 0.17 seconds
guestfsd: main_loop: new request, len 0x38
D, [2011-06-29T15:35:30.472830 #816] DEBUG -- : GFS: umount /dev/vda1
D, [2011-06-29T15:35:30.963031 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 2d | 00 00 00 01 | 00 12 34 10 | ...
T, [2011-06-29T15:35:30.963192 #816] TRACE -- : GFS: umount = 0
T, [2011-06-29T15:35:30.963327 #816] TRACE -- : Partition unmounted.
T, [2011-06-29T15:35:30.963428 #816] TRACE -- : All partitions unmounted.
D, [2011-06-29T15:35:30.963864 #816] DEBUG -- : SELinux policy was loaded, we're ready to sync filesystem.
I, [2011-06-29T15:35:30.964060 #816] INFO -- : Synchronizing filesystems...
T, [2011-06-29T15:35:30.965754 #816] TRACE -- : GFS: mkmountpoint "/in"
D, [2011-06-29T15:35:30.966054 #816] DEBUG -- : GFS: send_to_daemon: 52 bytes: 00 00 00 30 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 00 | ...
D, [2011-06-29T15:35:30.967411 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 45 (umount) took 0.49 seconds
D, [2011-06-29T15:35:30.969245 #816] DEBUG -- : GFS: guestfsd: main_loop: new request, len 0x30
D, [2011-06-29T15:35:30.971189 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 01 | 00 12 34 11 | ...
T, [2011-06-29T15:35:30.971327 #816] TRACE -- : GFS: mkmountpoint = 0
T, [2011-06-29T15:35:30.971458 #816] TRACE -- : GFS: mkmountpoint "/out"
D, [2011-06-29T15:35:30.971972 #816] DEBUG -- : GFS: send_to_daemon: 52 bytes: 00 00 00 30 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 00 | ...
D, [2011-06-29T15:35:30.973942 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 148 (mkmountpoint) took 0.00 seconds
guestfsd: main_loop: new request, len 0x30
D, [2011-06-29T15:35:30.974999 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 01 | 00 12 34 12 | ...
T, [2011-06-29T15:35:30.975152 #816] TRACE -- : GFS: mkmountpoint = 0
T, [2011-06-29T15:35:30.975297 #816] TRACE -- : GFS: mkmountpoint "/out/in"
D, [2011-06-29T15:35:30.975683 #816] DEBUG -- : GFS: send_to_daemon: 56 bytes: 00 00 00 34 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 00 | ...
D, [2011-06-29T15:35:30.977335 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 148 (mkmountpoint) took 0.00 seconds
guestfsd: main_loop: new request, len 0x34
D, [2011-06-29T15:35:30.978507 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 94 | 00 00 00 01 | 00 12 34 13 | ...
T, [2011-06-29T15:35:30.978759 #816] TRACE -- : GFS: mkmountpoint = 0
T, [2011-06-29T15:35:30.978943 #816] TRACE -- : GFS: mkfs "ext4" "/dev/vdb"
D, [2011-06-29T15:35:30.979187 #816] DEBUG -- : GFS: send_to_daemon: 64 bytes: 00 00 00 3c | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 2a | 00 00 00 00 | ...
D, [2011-06-29T15:35:30.981001 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 148 (mkmountpoint) took 0.00 seconds
guestfsd: main_loop: new request, len 0x3c
D, [2011-06-29T15:35:30.985156 #816] DEBUG -- : GFS: mke2fs -t ext4 -F /dev/vdb
D, [2011-06-29T15:35:31.110359 #816] DEBUG -- : GFS: mke2fs 1.41.14 (22-Dec-2010)
D, [2011-06-29T15:35:57.515756 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 2a | 00 00 00 01 | 00 12 34 14 | ...
T, [2011-06-29T15:35:57.515948 #816] TRACE -- : GFS: mkfs = 0
T, [2011-06-29T15:35:57.516103 #816] TRACE -- : GFS: set_e2label "/dev/vdb" "79d3d2d4"
D, [2011-06-29T15:35:57.516375 #816] DEBUG -- : GFS: send_to_daemon: 68 bytes: 00 00 00 40 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...
D, [2011-06-29T15:35:57.518811 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 42 (mkfs) took 12.45 seconds
guestfsd: main_loop: new request, len 0x40
D, [2011-06-29T15:35:57.522874 #816] DEBUG -- : GFS: e2label /dev/vdb 79d3d2d4
D, [2011-06-29T15:35:57.524659 #816] DEBUG -- : GFS:
D, [2011-06-29T15:35:57.794028 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 15 | ...
T, [2011-06-29T15:35:57.794212 #816] TRACE -- : GFS: set_e2label = 0
T, [2011-06-29T15:35:57.794320 #816] TRACE -- : Mounting /dev/vdb partition to /out/in...
T, [2011-06-29T15:35:57.794433 #816] TRACE -- : GFS: mount_options "" "/dev/vdb" "/out/in"
D, [2011-06-29T15:35:57.794920 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 00 | ...
D, [2011-06-29T15:35:57.797001 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.27 seconds
guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:35:57.799761 #816] DEBUG -- : GFS: mount -o /dev/vdb /sysroot/out/in
D, [2011-06-29T15:35:58.181019 #816] DEBUG -- : GFS: [   51.942588] EXT4-fs (vdb): mounted filesystem with ordered data mode. Opts: (null)
D, [2011-06-29T15:35:58.242795 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 01 | 00 12 34 16 | ...
T, [2011-06-29T15:35:58.242981 #816] TRACE -- : GFS: mount_options = 0
T, [2011-06-29T15:35:58.243110 #816] TRACE -- : GFS: set_e2label "/dev/vdb" "a570ee9c"
D, [2011-06-29T15:35:58.243400 #816] DEBUG -- : GFS: send_to_daemon: 68 bytes: 00 00 00 40 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...
D, [2011-06-29T15:35:58.245778 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 74 (mount_options) took 0.43 seconds
guestfsd: main_loop: new request, len 0x40
D, [2011-06-29T15:35:58.249422 #816] DEBUG -- : GFS: e2label /dev/vdb a570ee9c
D, [2011-06-29T15:35:58.584445 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 17 | ...
T, [2011-06-29T15:35:58.584856 #816] TRACE -- : GFS: set_e2label = 0
T, [2011-06-29T15:35:58.584978 #816] TRACE -- : Partition mounted.
T, [2011-06-29T15:35:58.585104 #816] TRACE -- : Mounting partitions...
T, [2011-06-29T15:35:58.585238 #816] TRACE -- : GFS: list_partitions
D, [2011-06-29T15:35:58.585655 #816] DEBUG -- : GFS: send_to_daemon: 44 bytes: 00 00 00 28 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 00 | ...
D, [2011-06-29T15:35:58.587811 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.33 seconds
guestfsd: main_loop: new request, len 0x28
D, [2011-06-29T15:35:58.592045 #816] DEBUG -- : GFS: recv_from_daemon: 76 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 08 | 00 00 00 01 | 00 12 34 18 | ...
T, [2011-06-29T15:35:58.592213 #816] TRACE -- : GFS: list_partitions = ["/dev/vda1", "/dev/vda2"]
T, [2011-06-29T15:35:58.592445 #816] TRACE -- : Mounting /dev/vda1 partition to /...
T, [2011-06-29T15:35:58.592719 #816] TRACE -- : GFS: mount_options "" "/dev/vda1" "/in/"
D, [2011-06-29T15:35:58.593007 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 00 | ...
D, [2011-06-29T15:35:58.596409 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 8 (list_partitions) took 0.00 seconds
guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:35:58.599148 #816] DEBUG -- : GFS: mount -o /dev/vda1 /sysroot/in/
D, [2011-06-29T15:35:58.985933 #816] DEBUG -- : GFS: [   52.732800] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
D, [2011-06-29T15:35:59.079589 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 01 | 00 12 34 19 | ...
T, [2011-06-29T15:35:59.079768 #816] TRACE -- : GFS: mount_options = 0
T, [2011-06-29T15:35:59.079935 #816] TRACE -- : GFS: set_e2label "/dev/vda1" "79d3d2d4"
D, [2011-06-29T15:35:59.097807 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...
D, [2011-06-29T15:35:59.102737 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 74 (mount_options) took 0.47 seconds
D, [2011-06-29T15:35:59.105434 #816] DEBUG -- : GFS: guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:35:59.121933 #816] DEBUG -- : GFS: e2label /dev/vda1 79d3d2d4
D, [2011-06-29T15:35:59.257268 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 1a | ...
T, [2011-06-29T15:35:59.257431 #816] TRACE -- : GFS: set_e2label = 0
T, [2011-06-29T15:35:59.257566 #816] TRACE -- : Partition mounted.
T, [2011-06-29T15:35:59.258127 #816] TRACE -- : Mounting /dev/vda2 partition to /SpeechMagic...
T, [2011-06-29T15:35:59.258265 #816] TRACE -- : GFS: mount_options "" "/dev/vda2" "/in/SpeechMagic"
D, [2011-06-29T15:35:59.258563 #816] DEBUG -- : GFS: send_to_daemon: 84 bytes: 00 00 00 50 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 00 | ...
D, [2011-06-29T15:35:59.260533 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.15 seconds
guestfsd: main_loop: new request, len 0x50
D, [2011-06-29T15:35:59.274954 #816] DEBUG -- : GFS: mount -o /dev/vda2 /sysroot/in/SpeechMagic
D, [2011-06-29T15:35:59.621727 #816] DEBUG -- : GFS: [   53.345371] EXT4-fs (vda2): mounted filesystem with ordered data mode. Opts: (null)
D, [2011-06-29T15:35:59.650033 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 4a | 00 00 00 01 | 00 12 34 1b | ...
T, [2011-06-29T15:35:59.650198 #816] TRACE -- : GFS: mount_options = 0
T, [2011-06-29T15:35:59.650327 #816] TRACE -- : GFS: set_e2label "/dev/vda2" "d8863c17"
D, [2011-06-29T15:35:59.650840 #816] DEBUG -- : GFS: send_to_daemon: 72 bytes: 00 00 00 44 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 00 | ...
D, [2011-06-29T15:35:59.652723 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 74 (mount_options) took 0.37 seconds
guestfsd: main_loop: new request, len 0x44
D, [2011-06-29T15:35:59.657418 #816] DEBUG -- : GFS: e2label /dev/vda2 d8863c17
D, [2011-06-29T15:35:59.762214 #816] DEBUG -- : GFS: recv_from_daemon: 40 bytes: 20 00 f5 f5 | 00 00 00 04 | 00 00 00 50 | 00 00 00 01 | 00 12 34 1c | ...
T, [2011-06-29T15:35:59.762436 #816] TRACE -- : GFS: set_e2label = 0
T, [2011-06-29T15:35:59.762742 #816] TRACE -- : Partition mounted.
D, [2011-06-29T15:35:59.762945 #816] DEBUG -- : Copying files...
T, [2011-06-29T15:35:59.763121 #816] TRACE -- : GFS: cp_a "/in/" "/out"
D, [2011-06-29T15:35:59.763399 #816] DEBUG -- : GFS: send_to_daemon: 60 bytes: 00 00 00 38 | 20 00 f5 f5 | 00 00 00 04 | 00 00 00 58 | 00 00 00 00 | ...
D, [2011-06-29T15:35:59.765395 #816] DEBUG -- : GFS: guestfsd: main_loop: proc 80 (set_e2label) took 0.10 seconds
guestfsd: main_loop: new request, len 0x38
D, [2011-06-29T15:35:59.792945 #816] DEBUG -- : GFS: cp -a /sysroot/in/ /sysroot/out

--Anton
Actions
5. Re: Building EBS on micro AMI, does not finish, ideas?

goldmann Jun 30, 2011 7:00 AM (in response to antonvank)
As you can see, your libguestfs memory setting wasn't set. The default value of 500 MB is being used:

D, [2011-06-29T15:33:45.916503 #862] DEBUG -- : GFS: [33282ms] /usr/lib/ruby/gems/1.8/gems/boxgrinder-build-0.9.2/lib/boxgrinder-build/helpers/qemu.wrapper \
    -drive file=build/appliances/i686/fedora/14/f14-Speech/fedora-plugin/f14-Speech-sda.raw,cache=off,if=virtio \
    -drive file=build/appliances/i686/fedora/14/f14-Speech/ec2-plugin/tmp/f14-Speech.ec2,cache=off,if=virtio \
    -nodefconfig \
    -nodefaults \
    -nographic \
    -m 500 \
    -no-reboot \
    -no-hpet \
    -device virtio-serial \
    -serial stdio \
    -chardev socket,path=/tmp/libguestfsh0E3ar/guestfsd.sock,id=channel0 \
    -device virtserialport,chardev=channel0,name=org.libguestfs.channel.0 \
    -netdev user,id=usernet,net=169.254.0.0/16 \
    -device virtio-net-pci,netdev=usernet \
    -kernel /tmp/.guestfs-0/kernel.816 \
    -initrd /tmp/.guestfs-0/initrd.816 \
    -append 'panic=1 console=ttyS0 udevtimeout=300 noapic acpi=off printk.time=1 cgroup_disable=memory selinux=1

Most probably you execute the build using sudo and you export the the value for current user, not root. Please execute:

$ sudo bash $ export LIBGUESTFS_MEMSIZE=300 $ boxgrinder-build f14-base.appl -p ec2 -d ebs -b --debug

This should do the trick.

--Marek
Actions
6. Re: Building EBS on micro AMI, does not finish, ideas?

goldmann Jun 30, 2011 8:51 AM (in response to goldmann)

Btw, we have created https://issues.jboss.org/browse/BGBUILD-246 so we want to make sure it'll not happen again.

--Marek
Actions
7. Re: Building EBS on micro AMI, does not finish, ideas?

antonvank Jun 30, 2011 9:34 AM (in response to goldmann)

Yes you are right I didn't pay attention to setting it to root. Applied the sudo bash and started it again
After 0.5 hour it finished
D, [2011-06-30T11:32:02.661954 #4064] DEBUG -- : Launching new BoxGrinder build...
I, [2011-06-30T12:08:54.019298 #4064] INFO -- : EBS AMI 'f14-Speech/fedora/14/1.0/i686' registered: ami-0cd12a65 (region: us-east-1)

Thanks for the support and glad to hear the situation will be prevented in future.

--Anton
Actions

Go to original post