Dspace Handle Server error

815 views

Skip to first unread message

Ahmet Melih Başbuğ

unread,

Feb 25, 2017, 9:38:23 AM2/25/17

to DSpace Technical Support

Hello. I have problem about handle server. It was working in past. but I restarted handle and it doesn't work. I can't understand why? We got handle.net account and it works. we configured settings before.

when I gave start-handle-server, it start to work and i can see command in ps -ef| grep handle.

root@dspaceetu-vm:/dspace/handle-server# ps -ef | grep handle

tomcat7 8481 1 0 16:13 pts/8 00:00:05 java -Xmx256m -classpath :/dspace/lib/JUnitParams-.......

i looked ports 8000 and 2641 with sudo netstat -tulpn | grep :2641 command but it doesn't show anything. In Iptables, I gave to 8000(tcp) and 2641(udp,tcp) permissions.

tail -100f handle-server.log

"2017/02/25 03:13:48 EET" 25 Rotating log files

moreover when i go http://hdl.handle.net/20.500.11851/317 I see Error - Cannot Connect to Server error. What could the error be? I can't find any mistake.

thanks

Melih

Mark Wood

unread,

Feb 27, 2017, 9:32:39 AM2/27/17

to DSpace Technical Support

It seems that the handle service is not opening sockets. If it isn't logging any errors at startup, you may have to run it in a system call tracer (strace, truss, whatever you have) and see what happens when it tries to open these sockets.

Silly question: the handle service *is* still configured to listen on those ports, yes?

Javier Távara

unread,

Feb 27, 2017, 10:07:51 AM2/27/17

to DSpace Technical Support

Hi.

Do you see any <handle-server>/error.log file? Are you behind nat?

Ahmet Melih Başbuğ

unread,

Feb 28, 2017, 1:42:55 AM2/28/17

to DSpace Technical Support

My network colleagues said ports were opened.

root@dspaceetu-vm:/home/dspaceuser# strace /dspace/bin/start-handle-server

execve("/dspace/bin/start-handle-server", ["/dspace/bin/start-handle-server"], [/* 38 vars */]) = 0

brk(0) = 0x55843c9cb000

access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)

mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fb5db596000

access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory)

open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3

fstat(3, {st_mode=S_IFREG|0644, st_size=80294, ...}) = 0

mmap(NULL, 80294, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7fb5db582000

close(3) = 0

access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)

open("/lib/x86_64-linux-gnu/libc.so.6", O_RDONLY|O_CLOEXEC) = 3

read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\37\2\0\0\0\0\0"..., 832) = 832

fstat(3, {st_mode=S_IFREG|0755, st_size=1840928, ...}) = 0

mmap(NULL, 3949248, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fb5dafb1000

mprotect(0x7fb5db16c000, 2093056, PROT_NONE) = 0

mmap(0x7fb5db36b000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1ba000) = 0x7fb5db36b000

mmap(0x7fb5db371000, 17088, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fb5db371000

close(3) = 0

mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fb5db581000

mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fb5db57f000

arch_prctl(ARCH_SET_FS, 0x7fb5db57f740) = 0

mprotect(0x7fb5db36b000, 16384, PROT_READ) = 0

mprotect(0x55843c31e000, 8192, PROT_READ) = 0

mprotect(0x7fb5db598000, 4096, PROT_READ) = 0

munmap(0x7fb5db582000, 80294) = 0

getpid() = 24829

rt_sigaction(SIGCHLD, {0x55843c115460, ~[RTMIN RT_1], SA_RESTORER, 0x7fb5dafe7d40}, NULL, 8) = 0

geteuid() = 0

brk(0) = 0x55843c9cb000

brk(0x55843c9ec000) = 0x55843c9ec000

getppid() = 24826

stat("/home/dspaceuser", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0

stat(".", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0

open("/dspace/bin/start-handle-server", O_RDONLY) = 3

fcntl(3, F_DUPFD, 10) = 10

close(3) = 0

fcntl(10, F_SETFD, FD_CLOEXEC) = 0

rt_sigaction(SIGINT, NULL, {SIG_DFL, [], 0}, 8) = 0

rt_sigaction(SIGINT, {0x55843c115460, ~[RTMIN RT_1], SA_RESTORER, 0x7fb5dafe7d40}, NULL, 8) = 0

rt_sigaction(SIGQUIT, NULL, {SIG_DFL, [], 0}, 8) = 0

rt_sigaction(SIGQUIT, {SIG_DFL, ~[RTMIN RT_1], SA_RESTORER, 0x7fb5dafe7d40}, NULL, 8) = 0

rt_sigaction(SIGTERM, NULL, {SIG_DFL, [], 0}, 8) = 0

rt_sigaction(SIGTERM, {SIG_DFL, ~[RTMIN RT_1], SA_RESTORER, 0x7fb5dafe7d40}, NULL, 8) = 0

read(10, "#!/bin/sh\n\n#####################"..., 8192) = 3089

pipe([3, 4]) = 0

clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fb5db57fa10) = 24830

close(4) = 0

read(3, "/dspace/bin\n", 128) = 12

--- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=24830, si_status=0, si_utime=0, si_stime=0} ---

rt_sigreturn() = 12

read(3, "", 128) = 0

close(3) = 0

wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0, NULL) = 24830

pipe([3, 4]) = 0

clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fb5db57fa10) = 24831

close(4) = 0

read(3, "/dspace\n", 128) = 8

--- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=24831, si_status=0, si_utime=0, si_stime=0} ---

rt_sigreturn() = 8

read(3, "", 128) = 0

close(3) = 0

wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0, NULL) = 24831

pipe([3, 4]) = 0

clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fb5db57fa10) = 24832

close(4) = 0

read(3, "/dspace/lib/JUnitParams-1.0.2.ja"..., 128) = 128

read(3, "/lib/ant-contrib-1.0b3.jar:/dspa"..., 128) = 128

read(3, "/dspace/lib/asm-4.2.jar:/dspace/"..., 128) = 128

read(3, "b/asm-util-4.1.jar:/dspace/lib/b"..., 128) = 128

read(3, "lib/bte-io-0.9.3.5.jar:/dspace/l"..., 128) = 128

read(3, "dspace/lib/commons-cli-1.2.jar:/"..., 128) = 128

read(3, "figuration-1.8.jar:/dspace/lib/c"..., 128) = 128

--- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=24832, si_status=0, si_utime=0, si_stime=0} ---

rt_sigreturn() = 128

read(3, "r:/dspace/lib/commons-io-2.3.jar"..., 128) = 128

read(3, "1.1.1.jar:/dspace/lib/commons-po"..., 128) = 128

read(3, "ce/lib/dnsjava-2.1.1.jar:/dspace"..., 128) = 128

read(3, "e/lib/dspace-oai-5.2-classes.jar"..., 128) = 128

read(3, "che-core-1.7.2.jar:/dspace/lib/e"..., 128) = 128

read(3, "/geoip-api-1.2.11.jar:/dspace/li"..., 128) = 128

read(3, "-api-services-analytics-v3-rev10"..., 128) = 128

read(3, ".19.0.jar:/dspace/lib/google-oau"..., 128) = 128

read(3, "lient-jetty-1.19.0.jar:/dspace/l"..., 128) = 128

read(3, "t-all-1.3.jar:/dspace/lib/handle"..., 128) = 128

read(3, "pcore-4.3.2.jar:/dspace/lib/http"..., 128) = 128

read(3, "tations-2.3.0.jar:/dspace/lib/ja"..., 128) = 128

read(3, "jar:/dspace/lib/jackson-mapper-a"..., 128) = 128

read(3, "x.inject-1.jar:/dspace/lib/jaxb-"..., 128) = 128

read(3, "4j-1.6.1.jar:/dspace/lib/jdbm-1."..., 128) = 128

read(3, "pace/lib/jena-core-2.12.0.jar:/d"..., 128) = 128

read(3, "/lib/jetty-util-6.1.26.jar:/dspa"..., 128) = 128

read(3, "ace/lib/jtwig-functions-2.0.1.ja"..., 128) = 128

read(3, "ommon-4.10.2.jar:/dspace/lib/luc"..., 128) = 128

read(3, ".jar:/dspace/lib/lucene-join-4.1"..., 128) = 128

read(3, "ne-queries-4.10.2.jar:/dspace/li"..., 128) = 128

read(3, "-4.10.2.jar:/dspace/lib/lucene-s"..., 128) = 128

read(3, "9.5.jar:/dspace/lib/mockito-core"..., 128) = 128

read(3, "/dspace/lib/oclc-harvester2-0.1."..., 128) = 128

read(3, "ace/lib/parboiled-core-1.1.6.jar"..., 128) = 128

read(3, "/dspace/lib/poi-3.6.jar:/dspace/"..., 128) = 128

read(3, "dspace/lib/postgresql-9.1-901-1."..., 128) = 128

read(3, "s-1.0.jar:/dspace/lib/servlet-ap"..., 128) = 128

read(3, "lf4j-log4j12-1.6.1.jar:/dspace/l"..., 128) = 128

read(3, "r:/dspace/lib/spring-asm-3.1.1.R"..., 128) = 128

read(3, "ar:/dspace/lib/spring-context-su"..., 128) = 128

read(3, "3.1.1.RELEASE.jar:/dspace/lib/sp"..., 128) = 128

read(3, "SE.jar:/dspace/lib/spring-webmvc"..., 128) = 128

read(3, "/wstx-asl-3.2.0.jar:/dspace/lib/"..., 128) = 128

read(3, "ParserAPIs-2.0.2.jar:/dspace/lib"..., 128) = 128

read(3, "-3.4.6.jar\n", 128) = 11

read(3, "", 128) = 0

close(3) = 0

wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0, NULL) = 24832

pipe([3, 4]) = 0

clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fb5db57fa10) = 24835

close(4) = 0

read(3, "/dspace/handle-server", 128) = 21

read(3, "\n", 128) = 1

read(3, "", 128) = 0

--- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=24835, si_status=0, si_utime=0, si_stime=0} ---

rt_sigreturn() = 0

close(3) = 0

wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0, NULL) = 24835

pipe([3, 4]) = 0

clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fb5db57fa10) = 24855

close(4) = 0

read(3, 0x7ffd8463cae0, 128) = ? ERESTARTSYS (To be restarted if SA_RESTART is set)

--- SIGWINCH {si_signo=SIGWINCH, si_code=SI_KERNEL} ---

read(3, 0x7ffd8463cae0, 128) = ? ERESTARTSYS (To be restarted if SA_RESTART is set)

--- SIGWINCH {si_signo=SIGWINCH, si_code=SI_KERNEL} ---

read(3, "/dspace/log", 128) = 11

read(3, "\n", 128) = 1

read(3, "", 128) = 0

--- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=24855, si_status=0, si_utime=0, si_stime=0} ---

rt_sigreturn() = 0

close(3) = 0

wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0, NULL) = 24855

stat("/usr/local/sbin/rm", 0x7ffd8463cb20) = -1 ENOENT (No such file or directory)

stat("/usr/local/bin/rm", 0x7ffd8463cb20) = -1 ENOENT (No such file or directory)

stat("/usr/sbin/rm", 0x7ffd8463cb20) = -1 ENOENT (No such file or directory)

stat("/usr/bin/rm", 0x7ffd8463cb20) = -1 ENOENT (No such file or directory)

stat("/sbin/rm", 0x7ffd8463cb20) = -1 ENOENT (No such file or directory)

stat("/bin/rm", {st_mode=S_IFREG|0755, st_size=60160, ...}) = 0

clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fb5db57fa10) = 24875

wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0, NULL) = 24875

--- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=24875, si_status=0, si_utime=0, si_stime=0} ---

rt_sigreturn() = 24875

clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fb5db57fa10) = 24876

read(10, "", 8192) = 0

exit_group(0) = ?

+++ exited with 0 +++

There is an error log. $Handle_server/error.log

"2017/02/28 08:22:30 EET" 100 class net.handle.server.HdlHttpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:27:30 EET" 100 class net.handle.server.HdlTcpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:27:30 EET" 100 class net.handle.server.HdlHttpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:27:30 EET" 100 class net.handle.server.HdlUdpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:32:30 EET" 100 class net.handle.server.HdlTcpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:32:30 EET" 100 class net.handle.server.HdlHttpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:32:30 EET" 100 class net.handle.server.HdlUdpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:37:30 EET" 100 class net.handle.server.HdlHttpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:37:30 EET" 100 class net.handle.server.HdlTcpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:37:30 EET" 100 class net.handle.server.HdlUdpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:42:30 EET" 100 class net.handle.server.HdlHttpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:42:30 EET" 100 class net.handle.server.HdlUdpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:42:30 EET" 100 class net.handle.server.HdlTcpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:47:30 EET" 100 class net.handle.server.HdlUdpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:47:30 EET" 100 class net.handle.server.HdlHttpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address"2017/02/28 08:47:30 EET" 100 class net.handle.server.HdlUdpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:47:30 EET" 100 class net.handle.server.HdlHttpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:47:30 EET" 100 class net.handle.server.HdlTcpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:49:21 EET" 25 Started new run.

"2017/02/28 08:49:21 EET" 50 unspecified max_handlers count, using default: 200

"2017/02/28 08:49:21 EET" 100 class net.handle.server.HdlUdpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:49:21 EET" 100 class net.handle.server.HdlTcpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

"2017/02/28 08:49:21 EET" 100 class net.handle.server.HdlHttpInterface: Error setting up server socket: java.net.BindException: Cannot assign requested address

Saving global values to: /root/.handle/root_info

thans.

Melih

25 Şubat 2017 Cumartesi 17:38:23 UTC+3 tarihinde Ahmet Melih Başbuğ yazdı:

Ahmet Melih Başbuğ

unread,

Feb 28, 2017, 2:51:39 AM2/28/17

to DSpace Technical Support

Hello. After i changed ip adress (I changed public ip to private ip..) I got new error.

Error - Resolution Error

The handle you requested --

20.500.11851/317

-- cannot be found.

What should i do ? I had items which included in past.

Thanks

Melih

25 Şubat 2017 Cumartesi 17:38:23 UTC+3 tarihinde Ahmet Melih Başbuğ yazdı:

Hello. I have problem about handle server. It was working in past. but I restarted handle and it doesn't work. I can't understand why? We got handle.net account and it works. we configured settings before.

Shaun donovan

unread,

Feb 28, 2017, 7:49:27 AM2/28/17

to Ahmet Melih Başbuğ, DSpace Technical Support

Hi Ahmet.

There are a few things to consider. Firstly, when you create the sitebundle.zip file, you must do it using the public IP address, as this is what CNRI use in their configuration. Then, because you are using a private IP address behind a firewall, you must go and change the IP addresses in the config.dct file in the handle-server directory, as you need to tell the handle server that it must bind to the private address.

The third step is to make sure that the puclic address port 2641 is forwarded to the private address port 2641 for both udp and tcp. You can test this using the netcat command as follows (but do it slowly):

nc -u uir.unisa.ac.za 2641

<enter> (wait three seconds)

<enter>(wait three seconds)

ctl-c

The fact that you could type enter and it did not kick you out shows that it is connected.

If you test against a machine that does not work:

nc -u www.teqcle.co.za 2641

<enter>(wait three seconds)

Ncat: No route to host.

--
You received this message because you are subscribed to the Google Groups "DSpace Technical Support" group.
To unsubscribe from this group and stop receiving emails from it, send an email to dspace-tech...@googlegroups.com.
To post to this group, send email to dspac...@googlegroups.com.
Visit this group at https://groups.google.com/group/dspace-tech.
For more options, visit https://groups.google.com/d/optout.

Shaun donovan

unread,

Feb 28, 2017, 7:58:46 AM2/28/17

to Ahmet Melih Başbuğ, DSpace Technical Support

Sorry, pressed send by mistake :-)

You can do the same test for TCP using:

nc -t uir.unisa.ac.za 2641

and you can also test for port 8000 (TCP only)

nc -t uir.unisa.ac.za 8000.

You must run these commands from outside of your network. If you give me your URL, I will run them for you.

Now that your handle server seems to be starting, what do you get from a netstat -nltup?

On 28/02/2017 09:51, Ahmet Melih Başbuğ wrote:

--

Ahmet Melih Başbuğ

unread,

Feb 28, 2017, 8:07:15 AM2/28/17

to DSpace Technical Support

root@dspaceetu-vm:/home/dspaceuser# netstat -nltup | grep 2641

tcp6 0 0 10.1.11.254:2641 :::* LISTEN 25778/java

udp6 0 0 10.1.11.254:2641 :::* 25778/java

root@dspaceetu-vm:/home/dspaceuser# netstat -nltup | grep 8000

tcp6 0 0 10.1.11.254:8000 :::* LISTEN 25778/java

I tested your examples and i understood. I tried outside of network. it didn't corrupted.

ahmet@localhost:~$ nc -t earsiv.etu.edu.tr 2641

This is the website of dspace.

http://earsiv.etu.edu.tr/xmlui/handle/20.500.11851/317
http://hdl.handle.net/20.500.11851/317

Thanks

Melih

28 Şubat 2017 Salı 15:58:46 UTC+3 tarihinde Shaun Donovan yazdı:

Reply all

Reply to author

Forward

0 new messages