Its a little long on now, but I was wondering what the resolution to this has been?
On Monday, January 6, 2014 3:02:58 PM UTC-5, Andrey Lomakin wrote: > > Hi Steven, > That is because restore procedure requires more memory than tx commit. We > will fix this issue > https://github.com/orientechnologies/orientdb/issues/1913 next week. > @Rubin I have written you that we fix it earlier but we extremely busy > with https://github.com/orientechnologies/orientdb/issues/1604 and we > should fix it next week. > > > > On Mon, Jan 6, 2014 at 8:46 PM, StevenTomer <[email protected] > <javascript:>> wrote: > >> Hello Andrey, >> >> I retried my test with the 1.6.3-hotfix I just downloaded today. >> Unfortunately, the problem is not fixed. >> >> When I try to reconnect after the failure, I get: >> >> 2014-01-06 18:36:33:773 INFO Loading configuration from: >> /root/releases/orientdb-community-1.6.3/config/orientdb-server-config.xml... >> [OServerConfigurationLoaderXml] >> 2014-01-06 18:36:34:350 INFO OrientDB Server v1.6.3 (build 2) is starting >> up... [OServer] >> 2014-01-06 18:36:34:359 INFO Databases directory: >> /root/releases/orientdb-community-1.6.3/databases [OServer] >> 2014-01-06 18:36:34:396 INFO Listening binary connections on 0.0.0.0:2424 >> (protocol v.19) [OServerNetworkListener] >> 2014-01-06 18:36:34:397 INFO Listening http connections on 0.0.0.0:2480 >> (protocol v.10) [OServerNetworkListener] >> 2014-01-06 18:36:34:410 INFO Installing dynamic plugin >> 'studio-1.6.2.zip'... [OServerPluginManager] >> 2014-01-06 18:36:34:492 INFO Mail plugin installed and active. Loaded 1 >> profile(s): [default] [OMailPlugin] >> 2014-01-06 18:36:34:494 INFO OrientDB Server v1.6.3 is active. [OServer] >> 2014-01-06 18:36:49:459 WARN segment file 'database.ocf' was not closed >> correctly last time [OSingleFileSegment] >> 2014-01-06 18:36:49:583 WARN Storage scratchpad was not closed properly. >> Will try to restore from write ahead log. [OLocalPaginatedStorage] >> 2014-01-06 18:36:49:584 INFO Try to find last checkpoint. >> [OLocalPaginatedStorage] >> 2014-01-06 18:36:50:146 INFO Found checkpoint is full checkpoint. >> [OLocalPaginatedStorage] >> 2014-01-06 18:36:50:148 INFO Data restore procedure from full checkpoint >> is started. Restore is performed from LSN OLogSequenceNumber{segment=0, >> position=138468} [OLocalPaginatedStorage] >> 2014-01-06 18:36:50:150 WARN Record >> OCheckpointEndRecord{lsn=OLogSequenceNumber{segment=0, position=138492}} >> will be skipped during data restore. [OLocalPaginatedStorage] >> 2014-01-06 18:36:52:160 INFO 10000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=1703469} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:36:53:732 INFO 20000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=3271497} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:36:55:536 INFO 30000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=4842677} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:36:57:078 INFO 40000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=6423209} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:36:58:632 INFO 50000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=8010283} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:00:172 INFO 60000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=9595656} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:01:712 INFO 70000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=11179922} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:03:254 INFO 80000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=12768147} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:04:789 INFO 90000 operations were processed, current LSN >> is OLogSequenceNumber{segment=0, position=14352369} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:06:522 INFO 100000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=18881171} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:08:295 INFO 110000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=30936639} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:09:860 INFO 120000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=39506245} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:11:440 INFO 130000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=50198999} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:13:368 INFO 140000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=61732053} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:14:940 INFO 150000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=73283007} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:17:666 INFO 160000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=85068861} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:19:265 INFO 170000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=102654087} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:20:880 INFO 180000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=126439528} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:23:572 INFO 190000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=148194591} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:25:166 INFO 200000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=164903851} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:26:756 INFO 210000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=180772181} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:29:762 INFO 220000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=191401241} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:31:488 INFO 230000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=192939865} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:33:275 INFO 240000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=194482947} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:35:056 INFO 250000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=196022918} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:36:606 INFO 260000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=197565355} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:38:139 INFO 270000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=199109259} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:39:969 INFO 280000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=200660028} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:41:509 INFO 290000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=202214617} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:43:048 INFO 300000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=203767590} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:44:587 INFO 310000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=205319964} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:46:123 INFO 320000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=206874543} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:47:668 INFO 330000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=208425300} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:49:218 INFO 340000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=209979796} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:50:760 INFO 350000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=211534290} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:52:307 INFO 360000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=213085156} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:53:850 INFO 370000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=214639746} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:55:462 INFO 380000 operations were processed, current >> LSN is OLogSequenceNumber{segment=0, position=235355052} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:37:59:244 INFO 390000 operations were processed, current >> LSN is OLogSequenceNumber{segment=1, position=32868566} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:01:570 INFO 400000 operations were processed, current >> LSN is OLogSequenceNumber{segment=1, position=94157983} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:03:843 INFO 410000 operations were processed, current >> LSN is OLogSequenceNumber{segment=1, position=136535110} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:07:609 INFO 420000 operations were processed, current >> LSN is OLogSequenceNumber{segment=1, position=165559476} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:11:310 INFO 430000 operations were processed, current >> LSN is OLogSequenceNumber{segment=1, position=219998987} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:13:390 INFO 440000 operations were processed, current >> LSN is OLogSequenceNumber{segment=2, position=26549731} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:17:456 INFO 450000 operations were processed, current >> LSN is OLogSequenceNumber{segment=2, position=103459262} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:19:733 INFO 460000 operations were processed, current >> LSN is OLogSequenceNumber{segment=2, position=163989221} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:21:357 INFO 470000 operations were processed, current >> LSN is OLogSequenceNumber{segment=2, position=186435780} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:26:387 INFO 480000 operations were processed, current >> LSN is OLogSequenceNumber{segment=2, position=256785206} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:28:983 INFO 490000 operations were processed, current >> LSN is OLogSequenceNumber{segment=3, position=84159122} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:39:482 INFO 500000 operations were processed, current >> LSN is OLogSequenceNumber{segment=3, position=172642125} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:48:364 INFO 510000 operations were processed, current >> LSN is OLogSequenceNumber{segment=3, position=219718732} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} [OLocalPaginatedStorage] >> 2014-01-06 18:38:57:077 INFO 520000 operations were processed, current >> LSN is OLogSequenceNumber{segment=3, position=252557326} last LSN is >> OLogSequenceNumber{segment=5, position=62730658} >> [OLocalPaginatedStorage]java.lang.OutOfMemoryError: Java heap space >> Dumping heap to java_pid1708.hprof ... >> Heap dump file created [2007835422 bytes in 13.103 secs] >> >> 2014-01-06 18:39:38:498 INFO Storage data restore was completed >> [OLocalPaginatedStorage] >> >> If I attempt to reconnect, the console shows 30000 records for class >> Person, not 60000. (It reverted to the state two transactions back, not >> the last successful transaction.) >> >> Steve >> >> >> On Thursday, December 19, 2013 9:09:06 AM UTC-7, Andrey Lomakin wrote: >> >>> Hi Steven, >>> Could you retry your test ? >>> >>> Best regards, >>> Andrey Lomakin. >>> >>> Orient Technologies >>> the Company behind OrientDB >>> >>> -- >> >> >> --- >> You received this message because you are subscribed to the Google Groups >> "OrientDB" group. >> To unsubscribe from this group and stop receiving emails from it, send an >> email to [email protected] <javascript:>. >> For more options, visit https://groups.google.com/groups/opt_out. >> > > > > -- > Best regards, > Andrey Lomakin. > > Orient Technologies > the Company behind OrientDB > > -- --- You received this message because you are subscribed to the Google Groups "OrientDB" group. To unsubscribe from this group and stop receiving emails from it, send an email to [email protected]. For more options, visit https://groups.google.com/d/optout.
