openjdk team mailing list archive

[Paul Gevers <elbrus@xxxxxxxxxx>]

Source: openjdk-9
Version: 9.0.4+12-1
Severity: normal
User: debian-ci@xxxxxxxxxxxxxxxx
Usertags: timeout

Since the upload of version 9.0.4+12-1 of openjdk-9, the autopkgtest¹
are regularly (but also worryingly not always) timing out (~ 3 hours)
while previous runs tested in about 1 minute (and failed). I copied some
log messages below. Could you please investigate how to get rid of the
timeout? And please fix your test to actually pass, but that is less
important now.

I have blacklisted openjdk-9 on ci.debian.net for now.

Don't hesitate to ask for help for the Debian CI team² if you need help
solving this issue.

Paul

¹ https://ci.debian.net/packages/o/openjdk-9/unstable/amd64/
² #debci on oftc or debian-ci@xxxxxxxxxxxxxxxx

https://ci.debian.net/data/autopkgtest/unstable/amd64/o/openjdk-9/262672/log.gz

Failed. Execution failed: `main' threw exception:
java.lang.reflect.InvocationTargetException
runner starting test:
javax/swing/JComboBox/ShowPopupAfterHidePopupTest/ShowPopupAfterHidePopupTest.java
runner finished test:
javax/swing/JComboBox/ShowPopupAfterHidePopupTest/ShowPopupAfterHidePopupTest.java
Failed. Execution failed: `main' threw exception: java.awt.AWTException:
headless environment
runner starting test: javax/swing/JComponent/4337267/bug4337267.java
autopkgtest [17:39:04]: ERROR: timed out on command "su -s /bin/bash
debci -c set -e; export USER=`id -nu`; . /etc/profile >/dev/null 2>&1 ||
true;  . ~/.profile >/dev/null 2>&1 || true;
buildtree="/tmp/autopkgtest-lxc.9kk8oooa/downtmp/build.2nn/src"; mkdir
-p -m 1777 --
"/tmp/autopkgtest-lxc.9kk8oooa/downtmp/command3-artifacts"; export
AUTOPKGTEST_ARTIFACTS="/tmp/autopkgtest-lxc.9kk8oooa/downtmp/command3-artifacts";
export ADT_ARTIFACTS="$AUTOPKGTEST_ARTIFACTS"; mkdir -p -m 755
"/tmp/autopkgtest-lxc.9kk8oooa/downtmp/autopkgtest_tmp"; export
AUTOPKGTEST_TMP="/tmp/autopkgtest-lxc.9kk8oooa/downtmp/autopkgtest_tmp";
export ADTTMP="$AUTOPKGTEST_TMP"; export DEBIAN_FRONTEND=noninteractive;
export LANG=C.UTF-8; export DEB_BUILD_OPTIONS=parallel=2; unset LANGUAGE
LC_CTYPE LC_NUMERIC LC_TIME LC_COLLATE   LC_MONETARY LC_MESSAGES
LC_PAPER LC_NAME LC_ADDRESS   LC_TELEPHONE LC_MEASUREMENT
LC_IDENTIFICATION LC_ALL;rm -f /tmp/autopkgtest_script_pid; set -C; echo
$$ > /tmp/autopkgtest_script_pid; set +C; trap "rm -f
/tmp/autopkgtest_script_pid" EXIT INT QUIT PIPE; cd "$buildtree"; touch
/tmp/autopkgtest-lxc.9kk8oooa/downtmp/command3-stdout
/tmp/autopkgtest-lxc.9kk8oooa/downtmp/command3-stderr; bash -ec
'debian/tests/jtreg-autopkgtest jdk' 2> >(tee -a
/tmp/autopkgtest-lxc.9kk8oooa/downtmp/command3-stderr >&2) > >(tee -a
/tmp/autopkgtest-lxc.9kk8oooa/downtmp/command3-stdout);" (kind: test)
autopkgtest [17:39:04]: test command3: -----------------------]
autopkgtest [17:39:05]: test command3:  - - - - - - - - - - results - -
- - - - - - - -
command3             FAIL timed out
autopkgtest [17:39:05]: test command3:  - - - - - - - - - - stderr - - -
- - - - - - -
xvfb-run: error: xauth command not found
[2018-05-08 15:01:51,685] Agent[0]: stderr: Picked up JAVA_TOOL_OPTIONS:
-XX:+IgnoreUnrecognizedVMOptions -XX:+PrintVMOptions -XX:+UseGOneGC
[2018-05-08 15:01:51,686] Agent[0]: stderr: Picked up _JAVA_OPTIONS:
-XX:+CheckJNICalls -XX:+UseCMSGC
[2018-05-08 15:01:51,686] Agent[0]: stderr: OpenJDK 64-Bit Server VM
warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and
will likely be removed in a future release.
[2018-05-08 16:18:14,129] Agent[1]: stderr: Waking
Thread[Finalizer,8,system]
[2018-05-08 16:47:55,320] Agent[1]: stderr: Timeout reached: 60000
[2018-05-08 16:47:55,320] Agent[1]: stderr: Process is not alive!
[2018-05-08 17:37:31,742] Agent[1]: stderr:
[2018-05-08 17:37:31,744] Agent[1]: stderr: Exception:
java.lang.SecurityException thrown from the UncaughtExceptionHandler in
thread "AWT-EventQueue-0"



https://ci.debian.net/data/autopkgtest/unstable/amd64/o/openjdk-9/255211/log.gz

autopkgtest [22:35:02]: test command1: [-----------------------
Error: Bad parameters specified: One of the files you specified was not
found. The error reported was:
/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/build.Uob/src/debian/excludelist.hotspot.jtx
(No such file or directory)
autopkgtest [22:35:04]: test command1: -----------------------]

and

Test results: passed: 3,724; failed: 16; error: 163
Report written to
/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command2-artifacts/langtools/JTreport/html/report.html
Results written to
/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command2-artifacts/langtools/JTwork
Error: Some tests failed or other problems occurred.
autopkgtest [22:46:01]: test command2: -----------------------]

and

Test results: passed: 6,131; failed: 1,123; error: 824
Report written to
/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTreport/html/report.html
Results written to
/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork
Error: Some tests failed or other problems occurred.
autopkgtest [23:57:59]: test command3: -----------------------]
autopkgtest [23:57:59]: test command3:  - - - - - - - - - - results - -
- - - - - - - -
command3             FAIL non-zero exit status 3
autopkgtest [23:57:59]: test command3:  - - - - - - - - - - stderr - - -
- - - - - - -
xvfb-run: error: xauth command not found
[2018-05-05 22:48:53,242] Agent[2]: stderr: Picked up JAVA_TOOL_OPTIONS:
-XX:+IgnoreUnrecognizedVMOptions -XX:+PrintVMOptions -XX:+UseGOneGC
[2018-05-05 22:48:53,242] Agent[2]: stderr: Picked up _JAVA_OPTIONS:
-XX:+CheckJNICalls -XX:+UseCMSGC
[2018-05-05 22:48:53,242] Agent[2]: stderr: OpenJDK 64-Bit Server VM
warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and
will likely be removed in a future release.
[2018-05-05 23:12:04,729] Agent[7]: stderr: Waking
Thread[Finalizer,8,system]
[2018-05-05 23:24:10,391] Agent[3]: stderr: Timeout reached: 60000
[2018-05-05 23:24:10,391] Agent[3]: stderr: Process is not alive!
[2018-05-05 23:37:47,995] Agent[0]: stderr:
[2018-05-05 23:37:47,995] Agent[0]: stderr: Exception:
java.lang.SecurityException thrown from the UncaughtExceptionHandler in
thread "AWT-EventQueue-0"
[2018-05-05 23:38:29,183] Agent[4]: stderr:
[2018-05-05 23:38:29,183] Agent[4]: stderr: Exception:
java.lang.SecurityException thrown from the UncaughtExceptionHandler in
thread "AWT-EventQueue-0"
Error: Some tests failed or other problems occurred.
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/4/sun/security/pkcs11/KeyStore/cert9.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/4/sun/security/pkcs11/KeyStore/key4.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/4/sun/security/pkcs11/Secmod/tmpdb/pkcs11.txt'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/4/sun/security/pkcs11/Secmod/tmpdb/cert9.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/4/sun/security/pkcs11/Secmod/tmpdb/key4.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/0/sun/security/pkcs11/Secmod/tmpdb/pkcs11.txt'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/0/sun/security/pkcs11/Secmod/tmpdb/cert9.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/0/sun/security/pkcs11/Secmod/tmpdb/key4.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/1/sun/security/pkcs11/Secmod/tmpdb/pkcs11.txt'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/1/sun/security/pkcs11/Secmod/tmpdb/cert9.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/1/sun/security/pkcs11/Secmod/tmpdb/key4.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/6/sun/security/pkcs11/Secmod/tmpdb/pkcs11.txt'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/6/sun/security/pkcs11/Secmod/tmpdb/cert9.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/6/sun/security/pkcs11/Secmod/tmpdb/key4.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/5/sun/security/pkcs11/Secmod/tmpdb/pkcs11.txt'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/5/sun/security/pkcs11/Secmod/tmpdb/cert9.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/5/sun/security/pkcs11/Secmod/tmpdb/key4.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/2/sun/security/pkcs11/Secmod/tmpdb/pkcs11.txt'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/2/sun/security/pkcs11/Secmod/tmpdb/cert9.db'
for reading: Permission denied
cp: cannot open
'/tmp/autopkgtest-lxc.q0kvlpmc/downtmp/command3-artifacts/jdk/JTwork/classes/2/sun/security/pkcs11/Secmod/tmpdb/key4.db'
for reading: Permission denied

Attachment: signature.asc
Description: OpenPGP digital signature