jenkins-admin at FreeBSD.org
2016-Jun-18 17:17 UTC
Build failed in Jenkins: FreeBSD_stable_10 #289
See <https://jenkins.FreeBSD.org/job/FreeBSD_stable_10/289/> ------------------------------------------ [...truncated 332190 lines...] [192.168.10.2] out: usr.bin/cpio/functional_test:test_passthrough_reverse -> passed [0.124s] [192.168.10.2] out: usr.bin/truncate/truncate_test:bad_refer -> passed [0.040s] [192.168.10.2] out: usr.bin/truncate/truncate_test:bad_truncate -> passed [0.052s] [192.168.10.2] out: usr.bin/truncate/truncate_test:cannot_open -> passed [0.088s] [192.168.10.2] out: usr.bin/truncate/truncate_test:illegal_option -> passed [0.041s] [192.168.10.2] out: usr.bin/truncate/truncate_test:illegal_size -> passed [0.040s] [192.168.10.2] out: usr.bin/truncate/truncate_test:negative -> passed [0.040s] [192.168.10.2] out: usr.bin/truncate/truncate_test:new_absolute_grow -> passed [0.079s] [192.168.10.2] out: usr.bin/truncate/truncate_test:new_absolute_shrink -> passed [0.081s] [192.168.10.2] out: usr.bin/truncate/truncate_test:new_relative_grow -> passed [0.082s] [192.168.10.2] out: usr.bin/truncate/truncate_test:new_relative_shrink -> passed [0.079s] [192.168.10.2] out: usr.bin/truncate/truncate_test:new_zero -> passed [0.049s] [192.168.10.2] out: usr.bin/truncate/truncate_test:no_files -> passed [0.039s] [192.168.10.2] out: usr.bin/truncate/truncate_test:opt_c -> passed [0.064s] [192.168.10.2] out: usr.bin/truncate/truncate_test:opt_rs -> passed [0.041s] [192.168.10.2] out: usr.bin/truncate/truncate_test:reference -> passed [0.094s] [192.168.10.2] out: usr.bin/truncate/truncate_test:too_large_size -> passed [0.042s] [192.168.10.2] out: usr.bin/apply/legacy_test:main -> passed [0.079s] [192.168.10.2] out: usr.bin/grep/grep_test:basic -> passed [0.047s] [192.168.10.2] out: usr.bin/grep/grep_test:begin_end -> passed [0.055s] [192.168.10.2] out: usr.bin/grep/grep_test:binary -> passed [0.091s] [192.168.10.2] out: usr.bin/grep/grep_test:context -> passed [0.123s] [192.168.10.2] out: usr.bin/grep/grep_test:context2 -> passed [0.081s] [192.168.10.2] out: usr.bin/grep/grep_test:egrep -> passed [0.050s] [192.168.10.2] out: usr.bin/grep/grep_test:file_exp -> passed [0.052s] [192.168.10.2] out: usr.bin/grep/grep_test:ignore_case -> passed [0.058s] [192.168.10.2] out: usr.bin/grep/grep_test:invert -> passed [0.059s] [192.168.10.2] out: usr.bin/grep/grep_test:negative -> passed [0.061s] [192.168.10.2] out: usr.bin/grep/grep_test:nonexistent -> passed [0.046s] [192.168.10.2] out: usr.bin/grep/grep_test:recurse -> passed [0.131s] [192.168.10.2] out: usr.bin/grep/grep_test:recurse_symlink -> passed [0.093s] [192.168.10.2] out: usr.bin/grep/grep_test:whole_line -> passed [0.045s] [192.168.10.2] out: usr.bin/grep/grep_test:word_regexps -> passed [0.046s] [192.168.10.2] out: usr.bin/grep/grep_test:zgrep -> passed [0.045s] [192.168.10.2] out: usr.bin/bmake/archives/fmt_44bsd/legacy_test:main -> passed [0.117s] [192.168.10.2] out: usr.bin/bmake/archives/fmt_44bsd_mod/legacy_test:main -> passed [0.116s] [192.168.10.2] out: usr.bin/bmake/archives/fmt_oldbsd/legacy_test:main -> passed [0.117s] [192.168.10.2] out: usr.bin/bmake/basic/t0/legacy_test:main -> passed [0.112s] [192.168.10.2] out: usr.bin/bmake/basic/t1/legacy_test:main -> passed [0.095s] [192.168.10.2] out: usr.bin/bmake/basic/t2/legacy_test:main -> passed [0.070s] [192.168.10.2] out: usr.bin/bmake/basic/t3/legacy_test:main -> passed [0.066s] [192.168.10.2] out: usr.bin/bmake/execution/ellipsis/legacy_test:main -> passed [0.070s] [192.168.10.2] out: usr.bin/bmake/execution/empty/legacy_test:main -> passed [0.068s] [192.168.10.2] out: usr.bin/bmake/execution/joberr/legacy_test:main -> passed [0.071s] [192.168.10.2] out: usr.bin/bmake/execution/plus/legacy_test:main -> passed [0.067s] [192.168.10.2] out: usr.bin/bmake/shell/builtin/legacy_test:main -> passed [0.080s] [192.168.10.2] out: usr.bin/bmake/shell/meta/legacy_test:main -> passed [0.103s] [192.168.10.2] out: usr.bin/bmake/shell/path/legacy_test:main -> passed [0.078s] [192.168.10.2] out: usr.bin/bmake/shell/path_select/legacy_test:main -> passed [0.077s] [192.168.10.2] out: usr.bin/bmake/shell/replace/legacy_test:main -> passed [0.082s] [192.168.10.2] out: usr.bin/bmake/shell/select/legacy_test:main -> passed [0.069s] [192.168.10.2] out: usr.bin/bmake/suffixes/basic/legacy_test:main -> passed [0.078s] [192.168.10.2] out: usr.bin/bmake/suffixes/src_wild1/legacy_test:main -> passed [0.081s] [192.168.10.2] out: usr.bin/bmake/suffixes/src_wild2/legacy_test:main -> passed [0.103s] [192.168.10.2] out: usr.bin/bmake/syntax/directive-t0/legacy_test:main -> passed [0.077s] [192.168.10.2] out: usr.bin/bmake/syntax/enl/legacy_test:main -> passed [0.081s] [192.168.10.2] out: usr.bin/bmake/syntax/funny-targets/legacy_test:main -> passed [0.076s] [192.168.10.2] out: usr.bin/bmake/syntax/semi/legacy_test:main -> passed [0.077s] [192.168.10.2] out: usr.bin/bmake/sysmk/t0/2/1/legacy_test:main -> passed [0.114s] [192.168.10.2] out: usr.bin/bmake/sysmk/t1/2/1/legacy_test:main -> passed [0.177s] [192.168.10.2] out: usr.bin/bmake/sysmk/t2/2/1/legacy_test:main -> passed [0.263s] [192.168.10.2] out: usr.bin/bmake/variables/modifier_M/legacy_test:main -> passed [0.113s] [192.168.10.2] out: usr.bin/bmake/variables/modifier_t/legacy_test:main -> passed [0.115s] [192.168.10.2] out: usr.bin/bmake/variables/opt_V/legacy_test:main -> passed [0.120s] [192.168.10.2] out: usr.bin/bmake/variables/t0/legacy_test:main -> passed [0.102s] [192.168.10.2] out: usr.bin/col/col:rlf -> passed [0.087s] [192.168.10.2] out: usr.bin/tr/legacy_test:main -> passed [0.061s] [192.168.10.2] out: usr.bin/lastcomm/legacy_test:main -> passed [0.050s] [192.168.10.2] out: usr.bin/join/legacy_test:main -> passed [0.025s] [192.168.10.2] out: usr.bin/tar/functional_test:test_0 -> passed [0.108s] [192.168.10.2] out: usr.bin/tar/functional_test:test_basic -> passed [0.206s] [192.168.10.2] out: usr.bin/tar/functional_test:test_copy -> passed [8.356s] [192.168.10.2] out: usr.bin/tar/functional_test:test_empty_mtree -> passed [0.095s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_bz2 -> passed [0.079s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_grz -> passed [0.071s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_gz -> passed [0.076s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_lrz -> passed [0.082s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_lz -> passed [0.081s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_lz4 -> passed [0.076s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_lzma -> passed [0.088s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_lzo -> passed [0.079s] [192.168.10.2] out: usr.bin/tar/functional_test:test_extract_tar_xz -> passed [0.078s] [192.168.10.2] out: usr.bin/tar/functional_test:test_format_newc -> passed [0.123s] [192.168.10.2] out: usr.bin/tar/functional_test:test_help -> passed [0.081s] [192.168.10.2] out: usr.bin/tar/functional_test:test_leading_slash -> passed [0.092s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_C_upper -> passed [0.572s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_H_upper -> passed [0.263s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_L_upper -> passed [0.302s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_O_upper -> passed [0.160s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_T_upper -> passed [0.186s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_U_upper -> passed [0.283s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_X_upper -> passed [0.334s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_a -> passed [0.141s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_b -> passed [0.422s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_b64encode -> passed [0.093s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_exclude -> passed [0.303s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_gid_gname -> passed [0.101s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_grzip -> passed [0.066s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_j -> passed [0.104s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_k -> passed [0.201s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_keep_newer_files -> passed [0.114s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_lrzip -> passed [0.061s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_lz4 -> passed [0.090s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_lzma -> passed [0.081s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_lzop -> passed [0.081s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_n -> passed [0.134s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_newer_than -> passed [2.356s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_nodump -> passed [0.135s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_older_than -> passed [2.289s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_passphrase -> passed [0.077s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_q -> passed [0.181s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_r -> passed [0.113s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_s -> passed [1.139s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_uid_uname -> passed [0.113s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_uuencode -> passed [0.078s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_xz -> passed [0.073s] [192.168.10.2] out: usr.bin/tar/functional_test:test_option_z -> passed [0.078s] [192.168.10.2] out: usr.bin/tar/functional_test:test_patterns -> passed [0.197s] [192.168.10.2] out: usr.bin/tar/functional_test:test_print_longpath -> passed [0.088s] [192.168.10.2] out: usr.bin/tar/functional_test:test_stdio -> passed [0.157s] [192.168.10.2] out: usr.bin/tar/functional_test:test_strip_components -> passed [0.134s] [192.168.10.2] out: usr.bin/tar/functional_test:test_symlink_dir -> passed [0.335s] [192.168.10.2] out: usr.bin/tar/functional_test:test_version -> passed [0.108s] [192.168.10.2] out: usr.bin/yacc/yacc_tests:main -> passed [3.903s] [192.168.10.2] out: usr.bin/ncal/legacy_test:main -> passed [0.323s] [192.168.10.2] out: usr.bin/timeout/timeout:exit_numbers -> passed [0.413s] [192.168.10.2] out: usr.bin/timeout/timeout:invalid_command -> passed [0.037s] [192.168.10.2] out: usr.bin/timeout/timeout:invalid_signal -> passed [0.034s] [192.168.10.2] out: usr.bin/timeout/timeout:invalid_timeout -> passed [0.079s] [192.168.10.2] out: usr.bin/timeout/timeout:no_such_command -> passed [0.038s] [192.168.10.2] out: usr.bin/timeout/timeout:no_timeout -> passed [0.037s] [192.168.10.2] out: usr.bin/timeout/timeout:nominal -> passed [0.037s] [192.168.10.2] out: usr.bin/timeout/timeout:time_unit -> passed [0.070s] [192.168.10.2] out: usr.bin/timeout/timeout:with_a_child -> passed [0.558s] [192.168.10.2] out: usr.bin/cut/cut_test:basic -> passed [0.046s] [192.168.10.2] out: usr.bin/cut/cut_test:dflag -> passed [0.045s] [192.168.10.2] out: usr.bin/cut/cut_test:dsflag -> passed [0.046s] [192.168.10.2] out: usr.bin/cut/cut_test:latin1 -> passed [0.049s] [192.168.10.2] out: usr.bin/cut/cut_test:sflag -> passed [0.044s] [192.168.10.2] out: usr.bin/cut/cut_test:utf8 -> passed [0.054s] [192.168.10.2] out: [192.168.10.2] out: Results file id is usr_tests.20160618-161204-850528 [192.168.10.2] out: Results saved to /root/.kyua/store/results.usr_tests.20160618-161204-850528.db [192.168.10.2] out: [192.168.10.2] out: 5251/5252 passed (1 failed) [192.168.10.2] out: Warning: run() received nonzero return code 1 while executing 'kyua test'! [192.168.10.2] run: kyua report --verbose --results-filter passed,skipped,xfail,broken,failed --output test-report.txt [192.168.10.2] run: kyua report-junit --output=test-report.xml [192.168.10.2] run: shutdown -p now [192.168.10.2] out: Shutdown NOW! [192.168.10.2] out: shutdown: [pid 70956] [192.168.10.2] out: adcast 192.168.10.255 kyuatestprompt # GEOM_CONCAT: Device concat.KZKVj3 created (id=1313602384). GEOM_CONCAT: Disk md0 attached to concat.KZKVj3. GEOM_CONCAT: Disk md1 attached to concat.KZKVj3. GEOM_CONCAT: Disk md2 attached to concat.KZKVj3. GEOM_CONCAT: Device concat/concat.KZKVj3 activated. GEOM_CONCAT: Disk md2 removed from concat.KZKVj3. GEOM_CONCAT: Device concat/concat.KZKVj3 deactivated. GEOM_CONCAT: Disk md1 removed from concat.KZKVj3. GEOM_CONCAT: Disk md0 removed from concat.KZKVj3. GEOM_CONCAT: Device concat.KZKVj3 destroyed. GEOM_CONCAT: Device concat.qIpLpW created (id=3291601578). GEOM_CONCAT: Disk md0 attached to concat.qIpLpW. GEOM_CONCAT: Disk md1 attached to concat.qIpLpW. GEOM_CONCAT: Disk md2 attached to concat.qIpLpW. GEOM_CONCAT: Device concat/concat.qIpLpW activated. GEOM_CONCAT: Disk md2 removed from concat.qIpLpW. GEOM_CONCAT: Device concat/concat.qIpLpW deactivated. GEOM_CONCAT: Disk md1 removed from concat.qIpLpW. GEOM_CONCAT: Disk md0 removed from concat.qIpLpW. GEOM_CONCAT: Device concat.qIpLpW destroyed. cryptosoft0: <software crypto> on motherboard GEOM_ELI: Device md0.eli created. GEOM_ELI: Encryption: AES-XTS 128 GEOM_ELI: Crypto: software GEOM_ELI: Device md0.eli destroyed. GEOM_ELI: Detached md0.eli on last close. GEOM_ELI: Device md0.eli created. GEOM_ELI: Encryption: AES-XTS 128 GEOM_ELI: Crypto: software GEOM_ELI: Device md0.eli destroyed. GEOM_ELI: Device md0.eli created. GEOM_ELI: Encryption: AES-XTS 128 GEOM_ELI: Crypto: software GEOM_ELI: Device md0.eli destroyed. GEOM_ELI: Device md0.eli created. GEOM_ELI: Encryption: AES-XTS 128 GEOM_ELI: Crypto: software GEOM_ELI: Device md0.eli destroyed. GEOM_ELI: Device md0.eli created. GEOM_ELI: Encryption: AES-XTS 128 GEOM_ELI: Crypto: software GEOM_ELI: Device md0.eli destroyed. GEOM_ELI: Device md0.eli created. GEOM_ELI: Encryption: AES-XTS 128 GEOM_ELI: Crypto: software GEOM_ELI: Device md0.eTraceback (most recent call last): File "freebsd-ci/scripts/test/run-tests.py", line 207, in <module> main(sys.argv) File "freebsd-ci/scripts/test/run-tests.py", line 79, in main runTest() File "freebsd-ci/scripts/test/run-tests.py", line 187, in runTest child2.expect(pexpect.EOF, timeout=1000) File "/usr/local/lib/python2.7/site-packages/pexpect/__init__.py", line 1451, in expect timeout, searchwindowsize) File "/usr/local/lib/python2.7/site-packages/pexpect/__init__.py", line 1466, in expect_list timeout, searchwindowsize) File "/usr/local/lib/python2.7/site-packages/pexpect/__init__.py", line 1568, in expect_loop raise TIMEOUT(str(err) + '\n' + str(self)) pexpect.TIMEOUT: Timeout exceeded. <pexpect.spawn object at 0x8053b0dd0> version: 3.3 command: /usr/sbin/bhyve args: [u'/usr/sbin/bhyve', u'-c', u'2', u'-m', u'2G', u'-AI', u'-H', u'-P', u'-g', u'0', u'-s', u'0:0,hostbridge', u'-s', u'1:0,lpc', u'-s', u'2:0,virtio-net,tap10,mac=58:9c:fc:00:00:2e', u'-s', u'3:0,ahci-hd,/net/jenkins-10.freebsd.org//builds/workspace/FreeBSD_stable_10/image/src/test.img', u'-l', u'com1,stdio', u'vm_test'] searcher: <pexpect.searcher_re object at 0x8053b0e50> buffer (last 100 chars): ' created.\r\nGEOM_ELI: Encryption: AES-XTS 128\r\nGEOM_ELI: Crypto: software\r\nGEOM_ELI: Device md0.e' before (last 100 chars): ' created.\r\nGEOM_ELI: Encryption: AES-XTS 128\r\nGEOM_ELI: Crypto: software\r\nGEOM_ELI: Device md0.e' after: <class 'pexpect.TIMEOUT'> match: None match_index: None exitstatus: None flag_eof: False pid: 61067 child_fd: 4 closed: False timeout: 30 delimiter: <class 'pexpect.EOF'> logfile: <open file '<stdout>', mode 'w' at 0x800671150> logfile_read: None logfile_send: None maxread: 2000 ignorecase: False searchwindowsize: None delaybeforesend: 0.05 delayafterclose: 0.1 delayafterterminate: 0.1 [Pipeline] } [Pipeline] // node [Pipeline] node Running on master in /usr/local/jenkins/workspace/FreeBSD_stable_10 [Pipeline] { [Pipeline] step