2012-04-25 06:42:58.885+0000: WARNING! Deprecated configuration options used. See manual for details 2012-04-25 06:42:58.888+0000: enable_online_backup has been replaced with online_backup_enabled and online_backup_port 2012-04-25 06:42:58.947+0000: Creating new db @ /home/andreas/projects/neo4j/lib/db/neostore 2012-04-25 06:42:59.281+0000: Opened [/home/andreas/projects/neo4j/lib/db/nioneo_logical.log.1] clean empty log, version=0, lastTxId=1 2012-04-25 06:42:59.296+0000: TM new log: tm_tx_log.1 2012-04-25 06:42:59.333+0000: Opened [/home/andreas/projects/neo4j/lib/db/index/lucene.log.1] clean empty log, version=0, lastTxId=1 2012-04-25 06:42:59.340+0000: --- STARTUP diagnostics START --- 2012-04-25 06:42:59.341+0000: Neo4j Kernel properties: read_only=false neo4j.ext.udc.host=udc.neo4j.org logical_log=/home/andreas/projects/neo4j/lib/db/nioneo_logical.log min_node_cache_size=0 intercept_committing_transactions=false node_auto_indexing=false remote_shell_name=shell cache_type=soft intercept_deserialized_transactions=false ha.db=NO use_adaptive_cache=YES lucene_searcher_cache_size=2147483647 neo4j.ext.udc.interval=86400000 use_memory_mapped_buffers=true ha.coordinators=localhost:2181,localhost:2182,localhost:2183 timestamps=YES rebuild_idgenerators_fast=true neostore.propertystore.db.index.keys.mapped_memory=1M max_node_cache_size=1500 neostore.propertystore.db.strings.mapped_memory=130M neostore.propertystore.db.arrays.mapped_memory=130M gcr_cache_min_log_interval=60s relationship_grab_size=100 relationship_auto_indexing=false remote_shell_read_only=false lucene_writer_cache_size=2147483647 storage_path=db node_cache_array_fraction=1.0 allow_store_upgrade=false execution_guard_enabled=false relationship_cache_array_fraction=1.0 migration_thread=NO remote_logging_host=127.0.0.1 store_dir=/home/andreas/projects/neo4j/lib/db remote_logging_port=4560 enable_rules=YES gc_monitor_threshold=200ms load_kernel_extensions=true array_block_size=120 neostore.relationshipstore.db.mapped_memory=50M dump_configuration=false gc_monitor_wait_time=100ms neostore.nodestore.db.mapped_memory=25M neo4j.ext.udc.first_delay=600000 remote_shell_enabled=true min_relationship_cache_size=0 max_relationship_cache_size=3500 neo4j.ext.udc.reg=unreg remote_shell_port=9332 adaptive_cache_heap_ratio=0.77 identity_map=NO adaptive_cache_manager_decrease_ratio=1.15 ha.server_id=2 neo_store=/home/andreas/projects/neo4j/lib/db/neostore adaptive_cache_worker_sleep_time=3000 neostore.propertystore.db.index.mapped_memory=1M adaptive_cache_manager_increase_ratio=1.1 backup_slave=false neostore.propertystore.db.mapped_memory=90M string_block_size=120 grab_file_lock=true remote_logging_enabled=false ha.server=localhost:6002 neo4j.ext.udc.enabled=true 2012-04-25 06:42:59.345+0000: Diagnostics providers: org.neo4j.kernel.configuration.Config org.neo4j.kernel.info.DiagnosticsManager SYSTEM_MEMORY JAVA_MEMORY OPERATING_SYSTEM JAVA_VIRTUAL_MACHINE CLASSPATH LIBRARY_PATH SYSTEM_PROPERTIES LINUX_SCHEDULERS 2012-04-25 06:42:59.346+0000: System memory information: Total Physical memory: 3.87 GB Free Physical memory: 1.99 GB Committed virtual memory: 907.15 MB Total swap space: 4.88 GB Free swap space: 4.88 GB 2012-04-25 06:42:59.349+0000: JVM memory information: Free memory: 55.76 MB Total memory: 108.56 MB Max memory: 444.50 MB Garbage Collector: PS Scavenge: [PS Eden Space, PS Survivor Space] Garbage Collector: PS MarkSweep: [PS Eden Space, PS Survivor Space, PS Old Gen, PS Perm Gen] Memory Pool: Code Cache (Non-heap memory): committed=2.63 MB, used=2.52 MB, max=48.00 MB, threshold=0.00 B Memory Pool: PS Eden Space (Heap memory): committed=62.00 MB, used=38.18 MB, max=154.00 MB, threshold=? Memory Pool: PS Survivor Space (Heap memory): committed=5.31 MB, used=5.30 MB, max=5.31 MB, threshold=? Memory Pool: PS Old Gen (Heap memory): committed=41.25 MB, used=9.33 MB, max=333.38 MB, threshold=0.00 B Memory Pool: PS Perm Gen (Non-heap memory): committed=25.81 MB, used=25.69 MB, max=166.00 MB, threshold=0.00 B 2012-04-25 06:42:59.357+0000: Operating system information: Operating System: Linux; version: 3.0.0-17-generic; arch: amd64; cpus: 2 Max number of file descriptors: 4096 Number of open file descriptors: 58 Process id: 2694@andreas-dell Byte order: LITTLE_ENDIAN 2012-04-25 06:42:59.362+0000: JVM information: VM Name: OpenJDK 64-Bit Server VM VM Vendor: Oracle Corporation VM Version: 21.0-b17 JIT compiler: HotSpot 64-Bit Tiered Compilers VM Arguments: [-Djdk.home=, -Djruby.home=/home/andreas/.rvm/rubies/jruby-1.6.7, -Djruby.script=jruby, -Djruby.shell=/bin/sh, -Djffi.boot.library.path=/home/andreas/.rvm/rubies/jruby-1.6.7/lib/native/ppc-Linux:/home/andreas/.rvm/rubies/jruby-1.6.7/lib/native/x86_64-Linux:/home/andreas/.rvm/rubies/jruby-1.6.7/lib/native/i386-Linux, -Xmx500m, -Xss2048k, -Djruby.memory.max=500m, -Djruby.stack.max=2048k, -Xbootclasspath/a:/home/andreas/.rvm/rubies/jruby-1.6.7/lib/jruby.jar] 2012-04-25 06:42:59.363+0000: Java classpath: [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7@global/gems/json-1.6.5-java/lib/json/ext/parser.jar [loader.2] file:/usr/lib/jvm/java-7-openjdk-common/jre/lib/ext/sunpkcs11.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/plugin.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/jce.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/neo4j-kernel-1.7.jar [bootstrap] /home/andreas/.rvm/rubies/jruby-1.6.7/lib/jruby.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/charsets.jar [loader.2] file:/usr/lib/jvm/java-7-openjdk-common/jre/lib/ext/localedata.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/jsse.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/neo4j-udc-1.7.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/sunrsasign.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/rhino.jar [loader.2] file:/usr/lib/jvm/java-7-openjdk-common/jre/lib/ext/dnsns.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/neo4j-graph-algo-1.7.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/org.apache.servicemix.bundles.jline-0.9.94_1.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/lucene-core-3.5.0.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/neo4j-cypher-1.7.jar [loader.2] file:/usr/lib/x86_64-linux-gnu/jni/libjava-access-bridge-jni.so.0.0.0 [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7@global/gems/json-1.6.5-java/lib/json/ext/generator.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/geronimo-jta_1.1_spec-1.1.1.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/scala-library-2.9.0-1.jar [loader.2] file:/usr/lib/jvm/java-7-openjdk-common/jre/lib/ext/sunjce_provider.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/netx.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/classes [loader.2] file:/usr/share/java/gnome-java-bridge.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/server-api-1.7.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/rt.jar [loader.2] file:/usr/lib/jvm/java-7-openjdk-common/jre/lib/ext/pulse-java.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/neo4j-graph-matching-1.7.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/neo4j-shell-1.7.jar [bootstrap] /usr/lib/jvm/java-7-openjdk-common/jre/lib/resources.jar [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/neo4j-jmx-1.7.jar [classpath + loader.1] file:/home/andreas/projects/neo4j/lib/ [loader.0] file:/home/andreas/.rvm/gems/jruby-1.6.7/gems/neo4j-community-1.7.0-java/lib/neo4j-community/jars/neo4j-lucene-index-1.7.jar [loader.2] file:/usr/lib/jvm/java-7-openjdk-common/jre/lib/ext/zipfs.jar 2012-04-25 06:42:59.367+0000: Library path: /usr/java/packages/lib/amd64 /usr/lib/x86_64-linux-gnu/jni /lib/x86_64-linux-gnu /usr/lib/x86_64-linux-gnu /usr/lib/jni /lib /usr/lib 2012-04-25 06:42:59.367+0000: System.properties: jruby.home = /home/andreas/.rvm/rubies/jruby-1.6.7 sun.boot.library.path = /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/amd64 path.separator = : file.encoding.pkg = sun.io user.country = US sun.java.launcher = SUN_STANDARD sun.os.patch.level = unknown user.dir = /home/andreas/projects/neo4j/lib jdk.home = sun.jnu.encoding = UTF-8 jruby.memory.max = 500m sun.management.compiler = HotSpot 64-Bit Tiered Compilers jffi.boot.library.path = /home/andreas/.rvm/rubies/jruby-1.6.7/lib/native/ppc-Linux:/home/andreas/.rvm/rubies/jruby-1.6.7/lib/native/x86_64-Linux:/home/andreas/.rvm/rubies/jruby-1.6.7/lib/native/i386-Linux user.home = /home/andreas user.timezone = Europe/Stockholm file.encoding = UTF-8 jruby.stack.max = 2048k jruby.script = jruby user.name = andreas jruby.shell = /bin/sh sun.java.command = org/jruby/Main /home/andreas/.rvm/rubies/jruby-1.6.7/bin/irb sun.arch.data.model = 64 user.language = en awt.toolkit = sun.awt.X11.XToolkit file.separator = / sun.io.unicode.encoding = UnicodeLittle sun.cpu.endian = little sun.desktop = gnome sun.cpu.isalist = 2012-04-25 06:42:59.368+0000: Linux scheduler information: none none none none none none none none none none none none none none none none none none none none none none none none noop deadline [cfq] noop deadline [cfq] 2012-04-25 06:42:59.372+0000: --- STARTUP diagnostics END --- 2012-04-25 06:42:59.446+0000: Extension org.neo4j.kernel.KernelExtension[kernel jmx] loaded ok 2012-04-25 06:42:59.712+0000: Extension org.neo4j.kernel.KernelExtension[shell] loaded ok 2012-04-25 06:42:59.714+0000: Extension org.neo4j.kernel.KernelExtension[kernel udc] loaded ok 2012-04-25 06:42:59.717+0000: --- STARTUP diagnostics for KernelDiagnostics:Versions START --- 2012-04-25 06:42:59.717+0000: Graph Database: org.neo4j.kernel.EmbeddedGraphDatabase StoreId[time:1335336178947, id:-2172206710464518899, store version: 13561656364791302] 2012-04-25 06:42:59.717+0000: Kernel version: Neo4j - Graph Database Kernel 1.7 2012-04-25 06:42:59.717+0000: Neo4j component versions: 2012-04-25 06:42:59.718+0000: Neo4j - Graph Database Kernel 1.7 2012-04-25 06:42:59.718+0000: --- STARTUP diagnostics for KernelDiagnostics:Versions END --- 2012-04-25 06:42:59.720+0000: --- STARTUP diagnostics for NEO_STORE_VERSIONS START --- 2012-04-25 06:42:59.720+0000: Store versions: Store versions: NeoStore v0.A.0 NodeStore v0.A.0 RelationshipStore v0.A.0 RelationshipTypeStore v0.A.0 PropertyStore v0.A.0 PropertyIndexStore v0.A.0 StringPropertyStore v0.A.0 ArrayPropertyStore v0.A.0 2012-04-25 06:42:59.720+0000: --- STARTUP diagnostics for NEO_STORE_VERSIONS END --- 2012-04-25 06:42:59.720+0000: --- STARTUP diagnostics for NEO_STORE_ID_USAGE START --- 2012-04-25 06:42:59.720+0000: Id usage: Id usage: NodeStore: used=1 high=0 RelationshipStore: used=0 high=-1 RelationshipTypeStore: used=0 high=-1 PropertyStore: used=0 high=-1 PropertyIndexStore: used=0 high=-1 StringPropertyStore: used=1 high=0 ArrayPropertyStore: used=1 high=0 2012-04-25 06:42:59.721+0000: --- STARTUP diagnostics for NEO_STORE_ID_USAGE END --- 2012-04-25 06:42:59.721+0000: --- STARTUP diagnostics for KernelDiagnostics:StoreFiles START --- 2012-04-25 06:42:59.721+0000: Storage files: neostore.relationshiptypestore.db.names: 38.00 B neostore.id: 9.00 B neostore.relationshiptypestore.db.names.id: 9.00 B neostore.nodestore.db.id: 9.00 B nioneo_logical.log.1: 16.00 B neostore.propertystore.db.index: 0.00 B neostore.propertystore.db.strings.id: 9.00 B nioneo_logical.log.active: 4.00 B neostore.propertystore.db.strings: 128.00 B neostore.relationshiptypestore.db.id: 9.00 B neostore: 54.00 B neostore.nodestore.db: 9.00 B neostore.propertystore.db.index.keys.id: 9.00 B neostore.propertystore.db.arrays.id: 9.00 B messages.log: 12.14 kB neostore.relationshipstore.db.id: 9.00 B neostore.propertystore.db.arrays: 128.00 B neostore.relationshipstore.db: 0.00 B neostore.propertystore.db.index.id: 9.00 B neostore.propertystore.db.id: 9.00 B neostore.propertystore.db: 0.00 B index: lucene-store.db: 40.00 B lucene.log.1: 16.00 B lucene.log.active: 4.00 B - Total: 60.00 B tm_tx_log.1: 0.00 B neostore.relationshiptypestore.db: 0.00 B lock: 0.00 B active_tx_log: 11.00 B neostore.propertystore.db.index.keys: 38.00 B 2012-04-25 06:42:59.723+0000: --- STARTUP diagnostics for KernelDiagnostics:StoreFiles END --- 2012-04-25 06:42:59.725+0000: Started - database is now available 2012-04-25 06:42:59.725+0000: GC Monitor started. 2012-04-25 07:42:59.916+0000: GC Monitor: Application threads blocked for an additional 238ms [total block time: 0.238s] 2012-04-25 09:43:00.185+0000: GC Monitor: Application threads blocked for an additional 123ms [total block time: 0.361s] 2012-04-25 13:16:52.462+0000: GC Monitor: Application threads blocked for an additional 1977426ms [total block time: 1977.787s] 2012-04-25 13:17:15.740+0000: GC Monitor: Application threads blocked for an additional 609ms [total block time: 1978.396s] 2012-04-25 13:43:00.715+0000: GC Monitor: Application threads blocked for an additional 142ms [total block time: 1978.538s] 2012-04-25 14:43:01.047+0000: GC Monitor: Application threads blocked for an additional 248ms [total block time: 1978.786s] 2012-04-25 17:43:01.553+0000: GC Monitor: Application threads blocked for an additional 135ms [total block time: 1978.921s] 2012-04-26 06:37:25.006+0000: GC Monitor: Application threads blocked for an additional 44031287ms [total block time: 46010.207s] 2012-04-26 08:37:26.005+0000: GC Monitor: Application threads blocked for an additional 825ms [total block time: 46011.03s] 2012-04-26 09:37:26.201+0000: GC Monitor: Application threads blocked for an additional 112ms [total block time: 46011.145s] 2012-04-26 11:37:26.540+0000: GC Monitor: Application threads blocked for an additional 160ms [total block time: 46011.305s] 2012-04-26 13:37:26.871+0000: GC Monitor: Application threads blocked for an additional 152ms [total block time: 46011.457s] 2012-04-26 15:37:27.191+0000: GC Monitor: Application threads blocked for an additional 115ms [total block time: 46011.57s] 2012-04-26 16:37:27.342+0000: GC Monitor: Application threads blocked for an additional 105ms [total block time: 46011.676s] 2012-04-26 18:37:27.643+0000: GC Monitor: Application threads blocked for an additional 146ms [total block time: 46011.824s] 2012-04-26 19:10:15.054+0000: GC Monitor: Application threads blocked for an additional 927ms [total block time: 46012.754s] 2012-04-26 19:37:27.802+0000: GC Monitor: Application threads blocked for an additional 144ms [total block time: 46012.895s] 2012-04-26 19:42:40.923+0000: Stopping - database is now unavailable 2012-04-26 19:42:40.932+0000: TM shutting down 2012-04-26 19:42:40.963+0000: GC Monitor stopped. 2012-04-26 19:42:41.226+0000: Closed log /home/andreas/projects/neo4j/lib/db/index/lucene.log 2012-04-26 19:42:41.257+0000: Closed log /home/andreas/projects/neo4j/lib/db/nioneo_logical.log