Help please - 10.1.0.4 aggregation dying
425613Apr 12 2005 — edited Apr 18 2005Hi,
I have an aggregation that is dying and I'm not sure exactly what is going on. I have a pretty large cube (12 dimensions - 1 dense and 11 sparse), and was trying to solve it with COMPRESSION turned on. Below I've attached the POUTFILEUNIT results.
Note that the solve died when the database ran out of temp space (at 20 Gb).
The POUTFILEUNIT looks weird to me - when I tried aggregating on a test cube (small), I got messages saying things like "2,800,000 total tuples" and having "2,400,000 singles" - impling that the compression would work wonders. However, I'm not seeing anything at all talking about singles in this POUTFILEUNIT.
How should I read this output and/or is it actually using the compression?
Thanks,
Scott
16:23:57.258 [ AW] Reattaching SYS.AWXML
16:23:57.258 [ AW] Done
16:23:57.367 [ AW] Reattaching DW_AW.TEST_RISKMGMT
16:23:57.367 [ AW] Done
16:23:57.883 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675 clean=all
16:23:58.805 [ AgClean] finish clean=all
16:23:58.805 [ AgDangle] start aggmap=TEST_RISKMGMT!OBJ993979675
16:23:58.805 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675 clean=memory
16:23:58.805 [ AgClean] finish clean=memory
16:23:58.820 [ AgDangle] finish
16:23:58.867 [ MHierCheck] start rel=TEST_RISKMGMT!AS_OF_DATE_PARENTREL multidim
16:23:58.867 [ MHierCheck] finish - validated
16:23:58.867 [ MHierCheck] start rel=TEST_RISKMGMT!OWNERSHIP_PARENTREL multidim
16:24:00.367 [ MHierCheck] finish - validated
16:24:00.367 [ MHierCheck] start rel=TEST_RISKMGMT!COMPLIANCE_RATING_PARENTREL multidim
16:24:00.367 [ MHierCheck] finish - validated
16:24:00.367 [ MHierCheck] start rel=TEST_RISKMGMT!SECURITY_PARENTREL multidim
16:24:00.555 [ MHierCheck] finish - validated
16:24:00.555 [ MHierCheck] start rel=TEST_RISKMGMT!EXPOSURE_PARENTREL multidim
16:24:00.633 [ MHierCheck] finish - validated
16:24:00.633 [ MHierCheck] start rel=TEST_RISKMGMT!PROPERTY_PARENTREL multidim
16:24:00.648 [ MHierCheck] finish - validated
16:24:00.648 [ MHierCheck] start rel=TEST_RISKMGMT!SETTLEMENT_DATE_PARENTREL multidim
16:24:00.680 [ MHierCheck] finish - validated
16:24:00.680 [ MHierCheck] start rel=TEST_RISKMGMT!TRADE_DATE_PARENTREL multidim
16:24:00.711 [ MHierCheck] finish - validated
16:24:00.711 [ MHierCheck] start rel=TEST_RISKMGMT!LINES_OF_BUSINESS_PARENTREL multidim
16:24:00.711 [ MHierCheck] finish - validated
16:24:00.711 [ MHierCheck] start rel=TEST_RISKMGMT!MATURITY_DATE_PARENTREL multidim
16:24:00.726 [ MHierCheck] finish - validated
16:24:00.726 [ MHierCheck] start rel=TEST_RISKMGMT!STATUS_PARENTREL multidim
16:24:00.726 [ MHierCheck] finish - validated
16:24:00.742 [ MHierCheck] start rel=TEST_RISKMGMT!SYSTEM_PARENTREL multidim
16:24:00.742 [ MHierCheck] finish - validated
16:24:00.742 [multipath check] start
16:24:00.742 [multipath check] finish
16:24:02.539 [multipath check] start
16:24:10.476 [multipath check] finish
16:24:10.679 [multipath check] start
16:24:10.695 [multipath check] finish
16:24:11.039 [multipath check] start
16:24:12.023 [multipath check] finish
16:24:12.367 [multipath check] start
16:24:12.820 [multipath check] finish
16:24:12.898 [multipath check] start
16:24:12.945 [multipath check] finish
16:24:13.023 [multipath check] start
16:24:13.101 [multipath check] finish
16:24:13.179 [multipath check] start
16:24:13.258 [multipath check] finish
16:24:13.320 [multipath check] start
16:24:13.336 [multipath check] finish
16:24:13.445 [multipath check] start
16:24:13.523 [multipath check] finish
16:24:13.539 [multipath check] start
16:24:13.539 [multipath check] finish
16:24:13.554 [multipath check] start
16:24:13.570 [multipath check] finish
16:24:13.586 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675 clean=session
16:24:13.633 [ AgClean] finish clean=session
16:24:13.633 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675 clean=session
16:24:13.633 [ AgClean] finish clean=session
16:24:15.445 [ SQL Import] Start
16:24:15.445 [ SQL Import] 13 defines done, starting SQL execution
16:25:40.851 [ SQL Import] finished SQL execution
16:25:48.663 [ SQL Import] row # 100001
16:25:53.960 [ SQL Import] row # 200001
16:25:58.413 [ SQL Import] row # 300001
16:26:02.491 [ SQL Import] row # 400001
16:26:06.116 [ SQL Import] row # 500001
16:26:09.976 [ SQL Import] row # 600001
16:26:14.569 [ SQL Import] row # 700001
16:26:19.100 [ SQL Import] row # 800001
16:26:25.069 [ SQL Import] row # 900001
16:26:29.725 [ SQL Import] row # 1000001
16:26:34.257 [ SQL Import] row # 1100001
16:26:38.507 [ SQL Import] row # 1200001
16:26:42.991 [ SQL Import] row # 1300001
16:26:47.303 [ SQL Import] row # 1400001
16:26:52.882 [ SQL Import] row # 1500001
16:26:57.397 [ SQL Import] row # 1600001
16:27:01.366 [ SQL Import] row # 1700001
16:27:05.850 [ SQL Import] row # 1800001
16:27:10.381 [ SQL Import] row # 1900001
16:27:14.725 [ SQL Import] row # 2000001
16:27:19.334 [ SQL Import] row # 2100001
16:27:23.834 [ SQL Import] row # 2200001
16:27:28.272 [ SQL Import] row # 2300001
16:27:32.631 [ SQL Import] row # 2400001
16:27:36.444 [ SQL Import] row # 2500001
16:27:40.662 [ SQL Import] row # 2600001
16:27:45.584 [ SQL Import] row # 2700001
16:27:51.303 [ SQL Import] normal finish, 2796291 rows
16:27:51.334 [ Update] start
16:27:51.381 [ Update] updating TEST_RISKMGMT
16:27:52.787 [ Solo update] DW_AW.TEST_RISKMGMT-33024-0 (new=1) pg 2-64 begin
16:27:52.834 [ Solo update] DW_AW.TEST_RISKMGMT-33024-0 2/2 pgs end
16:27:52.850 [ Solo update] DW_AW.TEST_RISKMGMT-33025-0 (new=1) pg 2-64 begin
16:27:52.959 [ Solo update] DW_AW.TEST_RISKMGMT-33025-0 11/11 pgs end
16:27:52.975 [ Solo update] DW_AW.TEST_RISKMGMT-33027-0 (new=1) pg 2-64 begin
16:27:53.069 [ Solo update] DW_AW.TEST_RISKMGMT-33027-0 4/4 pgs end
16:27:53.084 [ Solo update] DW_AW.TEST_RISKMGMT-33029-0 (new=1) pg 2-64 begin
16:27:53.178 [ Solo update] DW_AW.TEST_RISKMGMT-33029-0 4/4 pgs end
16:27:53.178 [ Solo update] DW_AW.TEST_RISKMGMT-33030-0 (new=1) pg 2-64 begin
16:27:53.178 [ Solo update] DW_AW.TEST_RISKMGMT-33030-0 2/2 pgs end
16:27:53.194 [ Solo update] DW_AW.TEST_RISKMGMT-33031-0 (new=1) pg 2-64 begin
16:27:53.287 [ Solo update] DW_AW.TEST_RISKMGMT-33031-0 5/5 pgs end
16:27:53.303 [ Solo update] DW_AW.TEST_RISKMGMT-33032-0 (new=1) pg 2-64 begin
16:27:53.350 [ Solo update] DW_AW.TEST_RISKMGMT-33032-0 2/2 pgs end
16:27:53.350 [ Solo update] DW_AW.TEST_RISKMGMT-33033-0 (new=1) pg 2-64 begin
16:27:53.381 [ Solo update] DW_AW.TEST_RISKMGMT-33033-0 5/5 pgs end
16:27:53.381 [ Solo update] DW_AW.TEST_RISKMGMT-33035-0 (new=1) pg 2-64 begin
16:27:53.444 [ Solo update] DW_AW.TEST_RISKMGMT-33035-0 4/4 pgs end
16:27:53.459 [ Solo update] DW_AW.TEST_RISKMGMT-33037-0 (new=1) pg 2-64 begin
16:27:53.584 [ Solo update] DW_AW.TEST_RISKMGMT-33037-0 4/4 pgs end
16:27:53.600 [ Solo update] DW_AW.TEST_RISKMGMT-33038-0 (new=1) pg 2-64 begin
16:27:53.678 [ Solo update] DW_AW.TEST_RISKMGMT-33038-0 2/2 pgs end
16:27:53.678 [ Solo update] DW_AW.TEST_RISKMGMT-33039-0 (new=1) pg 2-64 begin
16:27:53.787 [ Solo update] DW_AW.TEST_RISKMGMT-33039-0 7/7 pgs end
16:27:53.819 [ Solo update] DW_AW.TEST_RISKMGMT-33040-0 (new=1) pg 2-64 begin
16:27:53.850 [ Solo update] DW_AW.TEST_RISKMGMT-33040-0 2/2 pgs end
16:27:53.866 [ Solo update] DW_AW.TEST_RISKMGMT-33041-0 (new=1) pg 2-64 begin
16:27:53.881 [ Solo update] DW_AW.TEST_RISKMGMT-33041-0 10/10 pgs end
16:27:53.897 [ Solo update] DW_AW.TEST_RISKMGMT-33043-0 (new=1) pg 2-64 begin
16:27:54.006 [ Solo update] DW_AW.TEST_RISKMGMT-33043-0 4/4 pgs end
16:27:54.022 [ Solo update] DW_AW.TEST_RISKMGMT-33045-0 (new=1) pg 2-64 begin
16:27:54.084 [ Solo update] DW_AW.TEST_RISKMGMT-33045-0 4/4 pgs end
16:27:54.100 [ Solo update] DW_AW.TEST_RISKMGMT-33046-0 (new=1) pg 2-64 begin
16:27:54.100 [ Solo update] DW_AW.TEST_RISKMGMT-33046-0 2/2 pgs end
16:27:54.100 [ Solo update] DW_AW.TEST_RISKMGMT-33047-0 (new=1) pg 2-64 begin
16:27:54.178 [ Solo update] DW_AW.TEST_RISKMGMT-33047-0 5/5 pgs end
16:27:54.194 [ Solo update] DW_AW.TEST_RISKMGMT-33048-0 (new=1) pg 2-64 begin
16:27:54.194 [ Solo update] DW_AW.TEST_RISKMGMT-33048-0 2/2 pgs end
16:27:54.194 [ Solo update] DW_AW.TEST_RISKMGMT-33049-0 (new=1) pg 2-64 begin
16:27:54.225 [ Solo update] DW_AW.TEST_RISKMGMT-33049-0 5/5 pgs end
16:27:54.225 [ Solo update] DW_AW.TEST_RISKMGMT-33051-0 (new=1) pg 2-64 begin
16:27:54.303 [ Solo update] DW_AW.TEST_RISKMGMT-33051-0 4/4 pgs end
16:27:54.319 [ Solo update] DW_AW.TEST_RISKMGMT-33053-0 (new=1) pg 2-64 begin
16:27:54.350 [ Solo update] DW_AW.TEST_RISKMGMT-33053-0 4/4 pgs end
16:27:54.350 [ Solo update] DW_AW.TEST_RISKMGMT-33054-0 (new=1) pg 2-64 begin
16:27:54.350 [ Solo update] DW_AW.TEST_RISKMGMT-33054-0 2/2 pgs end
16:27:54.616 [ Solo update] DW_AW.TEST_RISKMGMT-30751-0 (new=0) pg 2-64 begin
16:27:54.647 [ Solo update] DW_AW.TEST_RISKMGMT-30751-0 2/25 pgs end
16:27:54.647 [ Solo update] DW_AW.TEST_RISKMGMT-33055-0 (new=1) pg 2-64 begin
16:27:54.694 [ Solo update] DW_AW.TEST_RISKMGMT-33055-0 5/5 pgs end
16:27:54.709 [ Solo update] DW_AW.TEST_RISKMGMT-33056-0 (new=1) pg 2-64 begin
16:27:54.725 [ Solo update] DW_AW.TEST_RISKMGMT-33056-0 2/2 pgs end
16:27:54.725 [ Solo update] DW_AW.TEST_RISKMGMT-33057-0 (new=1) pg 2-64 begin
16:27:54.803 [ Solo update] DW_AW.TEST_RISKMGMT-33057-0 5/5 pgs end
16:27:54.866 [ Solo update] DW_AW.TEST_RISKMGMT-30244-0 (new=0) pg 1-464 begin
16:27:54.975 [ Solo update] DW_AW.TEST_RISKMGMT-30244-0 8/465 pgs end
16:27:55.084 [ Solo update] DW_AW.TEST_RISKMGMT-30502-0 (new=0) pg 2-64 begin
16:27:55.084 [ Solo update] DW_AW.TEST_RISKMGMT-30502-0 2/15 pgs end
16:27:55.256 [ Solo update] DW_AW.TEST_RISKMGMT-29995-0 (new=0) pg 2-64 begin
16:27:55.272 [ Solo update] DW_AW.TEST_RISKMGMT-29995-0 2/9 pgs end
16:27:55.334 [ Solo update] DW_AW.TEST_RISKMGMT-32570-0 (new=0) pg 2-64 begin
16:27:55.350 [ Solo update] DW_AW.TEST_RISKMGMT-32570-0 2/5 pgs end
16:27:55.381 [ Solo update] DW_AW.TEST_RISKMGMT-32571-0 (new=0) pg 2-64 begin
16:27:55.397 [ Solo update] DW_AW.TEST_RISKMGMT-32571-0 2/2 pgs end
16:27:55.537 [ Solo update] DW_AW.TEST_RISKMGMT-32576-0 (new=0) pg 2-64 begin
16:27:55.584 [ Solo update] DW_AW.TEST_RISKMGMT-32576-0 2/2 pgs end
16:27:55.678 [ Solo update] DW_AW.TEST_RISKMGMT-32577-0 (new=0) pg 2-64 begin
16:27:55.694 [ Solo update] DW_AW.TEST_RISKMGMT-32577-0 2/4 pgs end
16:27:55.772 [ Solo update] DW_AW.TEST_RISKMGMT-32578-0 (new=0) pg 2-64 begin
16:27:55.850 [ Solo update] DW_AW.TEST_RISKMGMT-32578-0 2/2 pgs end
16:27:55.959 [ Solo update] DW_AW.TEST_RISKMGMT-32579-0 (new=0) pg 2-64 begin
16:27:56.006 [ Solo update] DW_AW.TEST_RISKMGMT-32579-0 2/4 pgs end
16:27:56.053 [ Solo update] DW_AW.TEST_RISKMGMT-32580-0 (new=0) pg 2-64 begin
16:27:56.100 [ Solo update] DW_AW.TEST_RISKMGMT-32580-0 2/2 pgs end
16:27:56.162 [ Solo update] DW_AW.TEST_RISKMGMT-32581-0 (new=0) pg 2-64 begin
16:27:56.178 [ Solo update] DW_AW.TEST_RISKMGMT-32581-0 2/4 pgs end
16:27:56.240 [ Solo update] DW_AW.TEST_RISKMGMT-32584-0 (new=0) pg 2-64 begin
16:27:56.272 [ Solo update] DW_AW.TEST_RISKMGMT-32584-0 2/2 pgs end
16:27:56.334 [ Solo update] DW_AW.TEST_RISKMGMT-32585-0 (new=0) pg 2-64 begin
16:27:56.350 [ Solo update] DW_AW.TEST_RISKMGMT-32585-0 2/4 pgs end
16:27:56.365 [ Solo update] DW_AW.TEST_RISKMGMT-32588-0 (new=0) pg 2-64 begin
16:27:56.381 [ Solo update] DW_AW.TEST_RISKMGMT-32588-0 2/2 pgs end
16:27:56.397 [ Solo update] DW_AW.TEST_RISKMGMT-32589-0 (new=0) pg 2-64 begin
16:27:56.397 [ Solo update] DW_AW.TEST_RISKMGMT-32589-0 2/4 pgs end
16:27:56.428 [ Solo update] DW_AW.TEST_RISKMGMT-32592-0 (new=0) pg 2-64 begin
16:27:56.428 [ Solo update] DW_AW.TEST_RISKMGMT-32592-0 2/2 pgs end
16:27:56.459 [ Solo update] DW_AW.TEST_RISKMGMT-32593-0 (new=0) pg 2-64 begin
16:27:56.490 [ Solo update] DW_AW.TEST_RISKMGMT-32593-0 2/4 pgs end
16:27:56.553 [ Solo update] DW_AW.TEST_RISKMGMT-32596-0 (new=0) pg 2-64 begin
16:27:56.553 [ Solo update] DW_AW.TEST_RISKMGMT-32596-0 2/2 pgs end
16:27:56.631 [ Solo update] DW_AW.TEST_RISKMGMT-32597-0 (new=0) pg 2-64 begin
16:27:56.709 [ Solo update] DW_AW.TEST_RISKMGMT-32597-0 2/4 pgs end
16:27:56.787 [ Solo update] DW_AW.TEST_RISKMGMT-32600-0 (new=0) pg 2-64 begin
16:27:56.850 [ Solo update] DW_AW.TEST_RISKMGMT-32600-0 2/2 pgs end
16:27:57.006 [ Solo update] DW_AW.TEST_RISKMGMT-32601-0 (new=0) pg 2-64 begin
16:27:57.022 [ Solo update] DW_AW.TEST_RISKMGMT-32601-0 2/4 pgs end
16:27:57.069 [ Solo update] DW_AW.TEST_RISKMGMT-32604-0 (new=0) pg 2-64 begin
16:27:57.069 [ Solo update] DW_AW.TEST_RISKMGMT-32604-0 2/2 pgs end
16:27:57.100 [ Solo update] DW_AW.TEST_RISKMGMT-32605-0 (new=0) pg 2-64 begin
16:27:57.147 [ Solo update] DW_AW.TEST_RISKMGMT-32605-0 2/4 pgs end
16:27:57.178 [ Solo update] DW_AW.TEST_RISKMGMT-32608-0 (new=0) pg 2-64 begin
16:27:57.194 [ Solo update] DW_AW.TEST_RISKMGMT-32608-0 2/2 pgs end
16:27:57.272 [ Solo update] DW_AW.TEST_RISKMGMT-32609-0 (new=0) pg 2-64 begin
16:27:57.287 [ Solo update] DW_AW.TEST_RISKMGMT-32609-0 2/4 pgs end
16:27:57.303 [ Solo update] DW_AW.TEST_RISKMGMT-32612-0 (new=0) pg 2-64 begin
16:27:57.319 [ Solo update] DW_AW.TEST_RISKMGMT-32612-0 2/2 pgs end
16:27:57.381 [ Solo update] DW_AW.TEST_RISKMGMT-32613-0 (new=0) pg 2-64 begin
16:27:57.397 [ Solo update] DW_AW.TEST_RISKMGMT-32613-0 2/4 pgs end
16:27:57.428 [ Solo update] DW_AW.TEST_RISKMGMT-32616-0 (new=0) pg 2-64 begin
16:27:57.428 [ Solo update] DW_AW.TEST_RISKMGMT-32616-0 2/2 pgs end
16:27:57.475 [ Solo update] DW_AW.TEST_RISKMGMT-32617-0 (new=0) pg 2-64 begin
16:27:57.475 [ Solo update] DW_AW.TEST_RISKMGMT-32617-0 2/4 pgs end
16:27:57.506 [ Solo update] DW_AW.TEST_RISKMGMT-32620-0 (new=0) pg 2-64 begin
16:27:57.537 [ Solo update] DW_AW.TEST_RISKMGMT-32620-0 2/2 pgs end
16:27:57.569 [ Solo update] DW_AW.TEST_RISKMGMT-32621-0 (new=0) pg 2-64 begin
16:27:57.584 [ Solo update] DW_AW.TEST_RISKMGMT-32621-0 2/4 pgs end
16:27:57.725 [ Solo update] DW_AW.TEST_RISKMGMT-30835-0 (new=0) pg 2-64 begin
16:27:57.772 [ Solo update] DW_AW.TEST_RISKMGMT-30835-0 2/8 pgs end
16:27:57.865 [ Solo update] DW_AW.TEST_RISKMGMT-30583-0 (new=0) pg 2-64 begin
16:27:57.897 [ Solo update] DW_AW.TEST_RISKMGMT-30583-0 2/9 pgs end
16:27:58.256 [ Solo update] DW_AW.TEST_RISKMGMT-30334-0 (new=0) pg 2-64 begin
16:27:58.272 [ Solo update] DW_AW.TEST_RISKMGMT-30334-0 2/10 pgs end
16:27:58.381 [ Solo update] DW_AW.TEST_RISKMGMT-30079-0 (new=0) pg 2-64 begin
16:27:58.490 [ Solo update] DW_AW.TEST_RISKMGMT-30079-0 2/9 pgs end
16:27:58.897 [ Solo update] DW_AW.TEST_RISKMGMT-30913-0 (new=0) pg 2-64 begin
16:27:58.959 [ Solo update] DW_AW.TEST_RISKMGMT-30913-0 2/25 pgs end
16:27:58.975 [ Solo update] DW_AW.TEST_RISKMGMT-32962-0 (new=1) pg 2-64 begin
16:27:58.990 [ Solo update] DW_AW.TEST_RISKMGMT-32962-0 2/2 pgs end
16:27:59.037 [ Solo update] DW_AW.TEST_RISKMGMT-32963-0 (new=1) pg 2-64 begin
16:27:59.069 [ Solo update] DW_AW.TEST_RISKMGMT-32963-0 5/5 pgs end
16:27:59.069 [ Solo update] DW_AW.TEST_RISKMGMT-32965-0 (new=1) pg 2-64 begin
16:27:59.178 [ Solo update] DW_AW.TEST_RISKMGMT-32965-0 4/4 pgs end
16:27:59.194 [ Solo update] DW_AW.TEST_RISKMGMT-32967-0 (new=1) pg 2-64 begin
16:27:59.225 [ Solo update] DW_AW.TEST_RISKMGMT-32967-0 4/4 pgs end
16:27:59.303 [ Solo update] DW_AW.TEST_RISKMGMT-30664-0 (new=0) pg 1-132 begin
16:27:59.397 [ Solo update] DW_AW.TEST_RISKMGMT-30664-0 8/133 pgs end
16:27:59.412 [ Solo update] DW_AW.TEST_RISKMGMT-32968-0 (new=1) pg 2-64 begin
16:27:59.444 [ Solo update] DW_AW.TEST_RISKMGMT-32968-0 2/2 pgs end
16:27:59.490 [ Solo update] DW_AW.TEST_RISKMGMT-32969-0 (new=1) pg 2-64 begin
16:27:59.600 [ Solo update] DW_AW.TEST_RISKMGMT-32969-0 5/5 pgs end
16:27:59.881 [ Solo update] DW_AW.TEST_RISKMGMT-29642-0 (new=0) pg 2-64 begin
16:27:59.897 [ Solo update] DW_AW.TEST_RISKMGMT-29642-0 5/28 pgs end
16:27:59.928 [ Solo update] DW_AW.TEST_RISKMGMT-29643-0 (new=0) pg 2-64 begin
16:27:59.990 [ Solo update] DW_AW.TEST_RISKMGMT-29643-0 2/2 pgs end
16:27:59.990 [ Solo update] DW_AW.TEST_RISKMGMT-32971-0 (new=1) pg 2-64 begin
16:27:59.990 [ Solo update] DW_AW.TEST_RISKMGMT-32971-0 4/4 pgs end
16:28:00.006 [ Solo update] DW_AW.TEST_RISKMGMT-32973-0 (new=1) pg 2-64 begin
16:28:00.084 [ Solo update] DW_AW.TEST_RISKMGMT-32973-0 4/4 pgs end
16:28:00.084 [ Solo update] DW_AW.TEST_RISKMGMT-32974-0 (new=1) pg 2-64 begin
16:28:00.162 [ Solo update] DW_AW.TEST_RISKMGMT-32974-0 3/44 pgs end
16:28:00.162 [ Solo update] DW_AW.TEST_RISKMGMT-32975-0 (new=1) pg 2-64 begin
16:28:00.584 [ Solo update] DW_AW.TEST_RISKMGMT-32975-0 52/52 pgs end
16:28:01.115 [ Solo update] DW_AW.TEST_RISKMGMT-30160-0 (new=0) pg 2-64 begin
16:28:01.178 [ Solo update] DW_AW.TEST_RISKMGMT-30160-0 2/64 pgs end
16:28:01.194 [ Solo update] DW_AW.TEST_RISKMGMT-32976-0 (new=1) pg 2-64 begin
16:28:01.225 [ Solo update] DW_AW.TEST_RISKMGMT-32976-0 3/44 pgs end
16:28:01.287 [ Solo update] DW_AW.TEST_RISKMGMT-32977-0 (new=1) pg 1-232 begin
16:28:03.100 [ Solo update] DW_AW.TEST_RISKMGMT-32977-0 231/233 pgs end
16:28:03.272 [ Solo update] DW_AW.TEST_RISKMGMT-30418-0 (new=0) pg 2-64 begin
16:28:03.287 [ Solo update] DW_AW.TEST_RISKMGMT-30418-0 2/23 pgs end
16:28:03.303 [ Solo update] DW_AW.TEST_RISKMGMT-32979-0 (new=1) pg 2-64 begin
16:28:03.381 [ Solo update] DW_AW.TEST_RISKMGMT-32979-0 4/4 pgs end
16:28:03.381 [ Solo update] DW_AW.TEST_RISKMGMT-32981-0 (new=1) pg 2-64 begin
16:28:03.397 [ Solo update] DW_AW.TEST_RISKMGMT-32981-0 4/4 pgs end
16:28:03.397 [ Solo update] DW_AW.TEST_RISKMGMT-32982-0 (new=1) pg 2-64 begin
16:28:03.412 [ Solo update] DW_AW.TEST_RISKMGMT-32982-0 2/2 pgs end
16:28:03.553 [ Solo update] DW_AW.TEST_RISKMGMT-31191-0 (new=0) pg 2-64 begin
16:28:03.569 [ Solo update] DW_AW.TEST_RISKMGMT-31191-0 3/6 pgs end
16:28:03.569 [ Solo update] DW_AW.TEST_RISKMGMT-32983-0 (new=1) pg 2-64 begin
16:28:03.584 [ Solo update] DW_AW.TEST_RISKMGMT-32983-0 5/5 pgs end
16:28:03.584 [ Solo update] DW_AW.TEST_RISKMGMT-32984-0 (new=1) pg 2-64 begin
16:28:03.600 [ Solo update] DW_AW.TEST_RISKMGMT-32984-0 2/2 pgs end
16:28:03.600 [ Solo update] DW_AW.TEST_RISKMGMT-32985-0 (new=1) pg 2-64 begin
16:28:03.615 [ Solo update] DW_AW.TEST_RISKMGMT-32985-0 5/5 pgs end
16:28:03.615 [ Solo update] DW_AW.TEST_RISKMGMT-32987-0 (new=1) pg 2-64 begin
16:28:03.725 [ Solo update] DW_AW.TEST_RISKMGMT-32987-0 4/4 pgs end
16:28:03.725 [ Solo update] DW_AW.TEST_RISKMGMT-32989-0 (new=1) pg 2-64 begin
16:28:03.772 [ Solo update] DW_AW.TEST_RISKMGMT-32989-0 4/4 pgs end
16:28:03.772 [ Solo update] DW_AW.TEST_RISKMGMT-32990-0 (new=1) pg 2-64 begin
16:28:03.819 [ Solo update] DW_AW.TEST_RISKMGMT-32990-0 3/12 pgs end
16:28:03.819 [ Solo update] DW_AW.TEST_RISKMGMT-32991-0 (new=1) pg 2-64 begin
16:28:04.115 [ Solo update] DW_AW.TEST_RISKMGMT-32991-0 29/29 pgs end
16:28:04.115 [ Solo update] DW_AW.TEST_RISKMGMT-32992-0 (new=1) pg 2-64 begin
16:28:04.131 [ Solo update] DW_AW.TEST_RISKMGMT-32992-0 3/12 pgs end
16:28:04.131 [ Solo update] DW_AW.TEST_RISKMGMT-32993-0 (new=1) pg 2-64 begin
16:28:04.537 [ Solo update] DW_AW.TEST_RISKMGMT-32993-0 51/51 pgs end
16:28:04.569 [ Solo update] DW_AW.TEST_RISKMGMT-32995-0 (new=1) pg 2-64 begin
16:28:04.584 [ Solo update] DW_AW.TEST_RISKMGMT-32995-0 4/4 pgs end
16:28:04.584 [ Solo update] DW_AW.TEST_RISKMGMT-32997-0 (new=1) pg 2-64 begin
16:28:04.662 [ Solo update] DW_AW.TEST_RISKMGMT-32997-0 4/4 pgs end
16:28:04.662 [ Solo update] DW_AW.TEST_RISKMGMT-32998-0 (new=1) pg 2-64 begin
16:28:04.662 [ Solo update] DW_AW.TEST_RISKMGMT-32998-0 2/2 pgs end
16:28:04.740 [ Solo update] DW_AW.TEST_RISKMGMT-32999-0 (new=1) pg 2-64 begin
16:28:04.912 [ Solo update] DW_AW.TEST_RISKMGMT-32999-0 11/11 pgs end
16:28:04.912 [ Solo update] DW_AW.TEST_RISKMGMT-33000-0 (new=1) pg 2-64 begin
16:28:04.928 [ Solo update] DW_AW.TEST_RISKMGMT-33000-0 2/2 pgs end
16:28:04.928 [ Solo update] DW_AW.TEST_RISKMGMT-33001-0 (new=1) pg 2-64 begin
16:28:05.100 [ Solo update] DW_AW.TEST_RISKMGMT-33001-0 24/24 pgs end
16:28:05.115 [ Solo update] DW_AW.TEST_RISKMGMT-33003-0 (new=1) pg 2-64 begin
16:28:05.115 [ Solo update] DW_AW.TEST_RISKMGMT-33003-0 4/4 pgs end
16:28:05.131 [ Solo update] DW_AW.TEST_RISKMGMT-33005-0 (new=1) pg 2-64 begin
16:28:05.178 [ Solo update] DW_AW.TEST_RISKMGMT-33005-0 4/4 pgs end
16:28:05.178 [ Solo update] DW_AW.TEST_RISKMGMT-33006-0 (new=1) pg 2-64 begin
16:28:05.178 [ Solo update] DW_AW.TEST_RISKMGMT-33006-0 2/2 pgs end
16:28:05.194 [ Solo update] DW_AW.TEST_RISKMGMT-33007-0 (new=1) pg 2-64 begin
16:28:05.303 [ Solo update] DW_AW.TEST_RISKMGMT-33007-0 6/6 pgs end
16:28:05.303 [ Solo update] DW_AW.TEST_RISKMGMT-33008-0 (new=1) pg 2-64 begin
16:28:05.334 [ Solo update] DW_AW.TEST_RISKMGMT-33008-0 2/2 pgs end
16:28:05.350 [ Solo update] DW_AW.TEST_RISKMGMT-33009-0 (new=1) pg 2-64 begin
16:28:05.428 [ Solo update] DW_AW.TEST_RISKMGMT-33009-0 8/8 pgs end
16:28:05.428 [ Solo update] DW_AW.TEST_RISKMGMT-33011-0 (new=1) pg 2-64 begin
16:28:05.522 [ Solo update] DW_AW.TEST_RISKMGMT-33011-0 4/4 pgs end
16:28:05.522 [ Solo update] DW_AW.TEST_RISKMGMT-33013-0 (new=1) pg 2-64 begin
16:28:05.537 [ Solo update] DW_AW.TEST_RISKMGMT-33013-0 4/4 pgs end
16:28:05.537 [ Solo update] DW_AW.TEST_RISKMGMT-33014-0 (new=1) pg 2-64 begin
16:28:05.553 [ Solo update] DW_AW.TEST_RISKMGMT-33014-0 2/2 pgs end
16:28:05.553 [ Solo update] DW_AW.TEST_RISKMGMT-33015-0 (new=1) pg 2-64 begin
16:28:05.569 [ Solo update] DW_AW.TEST_RISKMGMT-33015-0 8/8 pgs end
16:28:05.569 [ Solo update] DW_AW.TEST_RISKMGMT-33016-0 (new=1) pg 2-64 begin
16:28:05.631 [ Solo update] DW_AW.TEST_RISKMGMT-33016-0 2/2 pgs end
16:28:05.662 [ Solo update] DW_AW.TEST_RISKMGMT-33017-0 (new=1) pg 2-64 begin
16:28:05.725 [ Solo update] DW_AW.TEST_RISKMGMT-33017-0 11/11 pgs end
16:28:05.725 [ Solo update] DW_AW.TEST_RISKMGMT-33019-0 (new=1) pg 2-64 begin
16:28:05.819 [ Solo update] DW_AW.TEST_RISKMGMT-33019-0 4/4 pgs end
16:28:05.834 [ Solo update] DW_AW.TEST_RISKMGMT-33021-0 (new=1) pg 2-64 begin
16:28:05.850 [ Solo update] DW_AW.TEST_RISKMGMT-33021-0 4/4 pgs end
16:28:05.850 [ Solo update] DW_AW.TEST_RISKMGMT-33022-0 (new=1) pg 2-64 begin
16:28:05.850 [ Solo update] DW_AW.TEST_RISKMGMT-33022-0 2/2 pgs end
16:28:05.865 [ Solo update] DW_AW.TEST_RISKMGMT-33023-0 (new=1) pg 2-64 begin
16:28:05.959 [ Solo update] DW_AW.TEST_RISKMGMT-33023-0 8/8 pgs end
16:28:06.006 [ Para update] begin parallel update of 3 files w/ 3 nslaves.
16:28:37.021 [ Para update] ps 32567 ext 0 done 2664 pgs written
16:28:40.646 [ Para update] ps 32568 ext 0 done 3089 pgs written
16:29:38.896 [ Para update] ps 32573 ext 0 done 17314 pgs written
16:29:38.896 [ Para update] finished parallel update of 3 files w/ 3 nslaves.
16:29:39.302 [ Update] finish
16:29:40.771 [ MHierCheck] start rel=TEST_RISKMGMT!AS_OF_DATE_PARENTREL multidim
16:29:40.787 [ MHierCheck] finish - validated
16:29:40.787 [ MHierCheck] start rel=TEST_RISKMGMT!OWNERSHIP_PARENTREL multidim
16:29:41.990 [ MHierCheck] finish - validated
16:29:41.990 [ MHierCheck] start rel=TEST_RISKMGMT!COMPLIANCE_RATING_PARENTREL multidim
16:29:42.005 [ MHierCheck] finish - validated
16:29:42.005 [ MHierCheck] start rel=TEST_RISKMGMT!SECURITY_PARENTREL multidim
16:29:42.302 [ MHierCheck] finish - validated
16:29:42.302 [ MHierCheck] start rel=TEST_RISKMGMT!EXPOSURE_PARENTREL multidim
16:29:42.427 [ MHierCheck] finish - validated
16:29:42.427 [ MHierCheck] start rel=TEST_RISKMGMT!PROPERTY_PARENTREL multidim
16:29:42.443 [ MHierCheck] finish - validated
16:29:42.443 [ MHierCheck] start rel=TEST_RISKMGMT!SETTLEMENT_DATE_PARENTREL multidim
16:29:42.521 [ MHierCheck] finish - validated
16:29:42.521 [ MHierCheck] start rel=TEST_RISKMGMT!TRADE_DATE_PARENTREL multidim
16:29:42.552 [ MHierCheck] finish - validated
16:29:42.552 [ MHierCheck] start rel=TEST_RISKMGMT!LINES_OF_BUSINESS_PARENTREL multidim
16:29:42.552 [ MHierCheck] finish - validated
16:29:42.552 [ MHierCheck] start rel=TEST_RISKMGMT!MATURITY_DATE_PARENTREL multidim
16:29:42.584 [ MHierCheck] finish - validated
16:29:42.599 [ MHierCheck] start rel=TEST_RISKMGMT!STATUS_PARENTREL multidim
16:29:42.599 [ MHierCheck] finish - validated
16:29:42.599 [ MHierCheck] start rel=TEST_RISKMGMT!SYSTEM_PARENTREL multidim
16:29:42.599 [ MHierCheck] finish - validated
16:29:42.646 [multipath check] start
16:29:42.646 [multipath check] finish
16:29:44.474 [multipath check] start
16:29:52.287 [multipath check] finish
16:29:52.459 [multipath check] start
16:29:52.459 [multipath check] finish
16:29:52.802 [multipath check] start
16:29:53.865 [multipath check] finish
16:29:54.052 [multipath check] start
16:29:54.505 [multipath check] finish
16:29:54.568 [multipath check] start
16:29:54.630 [multipath check] finish
16:29:54.849 [multipath check] start
16:29:54.927 [multipath check] finish
16:29:55.005 [multipath check] start
16:29:55.083 [multipath check] finish
16:29:55.177 [multipath check] start
16:29:55.193 [multipath check] finish
16:29:55.302 [multipath check] start
16:29:55.380 [multipath check] finish
16:29:55.380 [multipath check] start
16:29:55.396 [multipath check] finish
16:29:55.474 [multipath check] start
16:29:55.474 [multipath check] finish
16:29:55.490 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675 clean=session
16:29:55.490 [ AgClean] finish clean=session
16:29:55.490 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675 clean=session
16:29:55.490 [ AgClean] finish clean=session
16:29:56.193 [ Aggregate] start func=0 vars=1
16:29:56.208 [ Aggregate] compound: <POSITIONS2_PRT_MEASDIM AS_OF_DATE POSITIONS2_COMPOSITE <OWNERSHIP COMPLIANCE_RATING SECURITY EXPOSURE __XML_GENERATED_7 SETTLEMENT_DATE TRADE_DATE LINES_OF_BUSINESS MATURITY_DATE STATUS __XML_GENERATED_12>>
16:29:56.208 [ Dimen] dim[0]=POSITIONS2_CO stval=443295 stlen=0 smax=-1 composite
16:29:56.208 [ Dimen] dim[1]=AS_OF_DATE stval=0 stlen=39 smax=38
16:29:56.208 [ Dimen] dim[2]=POSITIONS2_PR stval=0 stlen=1 smax=0
16:29:56.208 [ MHierCheck] start rel=TEST_RISKMGMT!AS_OF_DATE_PARENTREL multidim
16:29:56.208 [ MHierCheck] finish - validated
16:29:56.208 [ MHierCheck] start rel=TEST_RISKMGMT!OWNERSHIP_PARENTREL multidim
16:29:57.146 [ MHierCheck] finish - validated
16:29:57.146 [ MHierCheck] start rel=TEST_RISKMGMT!COMPLIANCE_RATING_PARENTREL multidim
16:29:57.146 [ MHierCheck] finish - validated
16:29:57.146 [ MHierCheck] start rel=TEST_RISKMGMT!SECURITY_PARENTREL multidim
16:29:57.365 [ MHierCheck] finish - validated
16:29:57.380 [ MHierCheck] start rel=TEST_RISKMGMT!EXPOSURE_PARENTREL multidim
16:29:57.443 [ MHierCheck] finish - validated
16:29:57.443 [ MHierCheck] start rel=TEST_RISKMGMT!PROPERTY_PARENTREL multidim
16:29:57.458 [ MHierCheck] finish - validated
16:29:57.474 [ MHierCheck] start rel=TEST_RISKMGMT!SETTLEMENT_DATE_PARENTREL multidim
16:29:57.490 [ MHierCheck] finish - validated
16:29:57.490 [ MHierCheck] start rel=TEST_RISKMGMT!TRADE_DATE_PARENTREL multidim
16:29:57.521 [ MHierCheck] finish - validated
16:29:57.521 [ MHierCheck] start rel=TEST_RISKMGMT!LINES_OF_BUSINESS_PARENTREL multidim
16:29:57.537 [ MHierCheck] finish - validated
16:29:57.537 [ MHierCheck] start rel=TEST_RISKMGMT!MATURITY_DATE_PARENTREL multidim
16:29:57.552 [ MHierCheck] finish - validated
16:29:57.552 [ MHierCheck] start rel=TEST_RISKMGMT!STATUS_PARENTREL multidim
16:29:57.552 [ MHierCheck] finish - validated
16:29:57.568 [ MHierCheck] start rel=TEST_RISKMGMT!SYSTEM_PARENTREL multidim
16:29:57.568 [ MHierCheck] finish - validated
16:30:00.974 [multipath check] start
16:30:00.974 [multipath check] finish
16:30:00.990 [ CCCovStat] start dim=POSITIONS2_COMPOSITE
16:30:00.990 [ CCCovStat] base __XML_GENERATED_12 (9 of 10 in status)
16:30:00.990 [ CCCovStat] base STATUS (30 of 34 in status)
16:30:00.990 [ CCCovStat] base MATURITY_DATE (2996 of 3675 in status)
16:30:00.990 [ CCCovStat] base LINES_OF_BUSINESS (211 of 278 in status)
16:30:00.990 [ CCCovStat] base TRADE_DATE (3623 of 4184 in status)
16:30:00.990 [ CCCovStat] base SETTLEMENT_DATE (3623 of 4208 in status)
16:30:00.990 [ CCCovStat] base __XML_GENERATED_7 (2090 of 2137 in status)
16:30:01.005 [ CCCovStat] base EXPOSURE (10846 of 10871 in status)
16:30:01.005 [ CCCovStat] base SECURITY (20353 of 20526 in status)
16:30:01.005 [ CCCovStat] base COMPLIANCE_RATING (23 of 32 in status)
16:30:01.005 [ CCCovStat] base OWNERSHIP (82599 of 83007 in status)
16:30:01.005 [ CCCovStat] build leafstat
16:30:07.208 [ CCCovStat] finished stlen=443296
16:30:07.365 [multipath check] start
16:30:15.365 [multipath check] finish
16:30:15.380 [multipath check] start
16:30:15.380 [multipath check] finish
16:30:15.380 [multipath check] start
16:30:16.365 [multipath check] finish
16:30:16.365 [multipath check] start
16:30:16.833 [multipath check] finish
16:30:16.849 [multipath check] start
16:30:16.896 [multipath check] finish
16:30:16.896 [multipath check] start
16:30:16.974 [multipath check] finish
16:30:16.974 [multipath check] start
16:30:17.052 [multipath check] finish
16:30:17.052 [multipath check] start
16:30:17.068 [multipath check] finish
16:30:17.068 [multipath check] start
16:30:17.130 [multipath check] finish
16:30:17.130 [multipath check] start
16:30:17.130 [multipath check] finish
16:30:17.146 [multipath check] start
16:30:17.146 [multipath check] finish
16:30:17.177 [ ccube] build dim=TEST_RISKMGMT!POSITIONS2_COMPOSITE
16:30:17.458 [ ccube] Relation TEST_RISKMGMT!SYSTEM_PARENTREL, cost=18
16:30:17.490 [ ccube] Relation TEST_RISKMGMT!COMPLIANCE_RATING_PARENTREL, cost=69
16:30:17.505 [ ccube] Relation TEST_RISKMGMT!STATUS_PARENTREL, cost=90
16:30:17.536 [ ccube] Relation TEST_RISKMGMT!LINES_OF_BUSINESS_PARENTREL, cost=844
16:30:17.583 [ ccube] Relation TEST_RISKMGMT!PROPERTY_PARENTREL, cost=6270
16:30:17.599 [ ccube] Relation TEST_RISKMGMT!MATURITY_DATE_PARENTREL, cost=11984
16:30:17.646 [ ccube] Relation TEST_RISKMGMT!SETTLEMENT_DATE_PARENTREL, cost=14492
16:30:17.693 [ ccube] Relation TEST_RISKMGMT!TRADE_DATE_PARENTREL, cost=14492
16:30:17.755 [ ccube] Relation TEST_RISKMGMT!EXPOSURE_PARENTREL, cost=43384
16:30:17.927 [ ccube] Relation TEST_RISKMGMT!SECURITY_PARENTREL, cost=81412
16:30:18.568 [ ccube] Relation TEST_RISKMGMT!OWNERSHIP_PARENTREL, cost=412995
16:30:31.224 [ ccube] calc input=443296
16:30:31.224 [ ccube] calc hierarchy 0
16:30:37.739 [ ccube] calc nodes=443296/443296
16:30:43.989 [ ccube] calc depth=1 classes=0 avgchildren=0.0
16:30:49.989 [ ccube] calc hierarchy 1
16:30:57.411 [ ccube] calc nodes=443296/443296
16:31:08.036 [ ccube] calc depth=1 classes=5704 avgchildren=2.0
16:31:13.036 [ ccube] calc nodes=437366/449000
16:31:23.989 [ ccube] calc depth=2 classes=5060 avgchildren=2.0
16:31:31.380 [ ccube] calc hierarchy 2
16:31:38.708 [ ccube] calc nodes=432272/454060
16:32:02.458 [ ccube] calc depth=1 classes=86862 avgchildren=2.1
16:32:08.551 [ ccube] calc nodes=339360/540922
16:32:32.786 [ ccube] calc depth=2 classes=49366 avgchildren=2.0
16:32:37.692 [ ccube] calc hierarchy 3
16:32:43.114 [ ccube] calc nodes=288911/592157
16:33:20.114 [ ccube] calc depth=1 classes=49202 avgchildren=3.5
16:33:22.754 [ ccube] calc nodes=166295/700035
16:33:48.176 [ ccube] calc depth=2 classes=16454 avgchildren=4.1
16:33:49.145 [ ccube] calc nodes=115662/736271
16:34:02.239 [ ccube] calc depth=3 classes=7094 avgchildren=2.9
16:34:03.489 [ ccube] calc hierarchy 4
16:34:04.520 [ ccube] calc nodes=101845/751904
16:34:07.270 [ ccube] calc depth=1 classes=179 avgchildren=2.0
16:34:08.004 [ ccube] calc nodes=101664/755186
16:34:08.786 [ ccube] calc depth=2 classes=17 avgchildren=2.0
16:34:09.536 [ ccube] calc hierarchy 5
16:34:10.957 [ ccube] calc nodes=101647/755326
16:34:12.895 [ ccube] calc depth=1 classes=66 avgchildren=2.0
16:34:13.582 [ ccube] calc nodes=101581/755833
16:34:15.395 [ ccube] calc depth=2 classes=38 avgchildren=2.0
16:34:16.067 [ ccube] calc nodes=101543/755988
16:34:17.645 [ ccube] calc depth=3 classes=75 avgchildren=2.0
16:34:18.582 [ ccube] calc hierarchy 6
16:34:19.504 [ ccube] calc nodes=101468/756486
16:34:21.348 [ ccube] calc depth=1 classes=79 avgchildren=2.0
16:34:22.098 [ ccube] calc nodes=101389/757609
16:34:23.520 [ ccube] calc depth=2 classes=39 avgchildren=2.0
16:34:24.051 [ ccube] calc nodes=101350/757998
16:34:24.504 [ ccube] calc depth=3 classes=0 avgchildren=0.0
16:34:25.254 [ ccube] calc hierarchy 7
16:34:26.114 [ ccube] calc nodes=101350/757998
16:34:27.551 [ ccube] calc depth=1 classes=8 avgchildren=2.0
16:34:28.348 [ ccube] calc nodes=101342/758010
16:34:30.239 [ ccube] calc depth=2 classes=8 avgchildren=2.0
16:34:31.161 [ ccube] calc nodes=101334/758106
16:34:31.848 [ ccube] calc depth=3 classes=0 avgchildren=0.0
16:34:32.801 [ ccube] calc hierarchy 8
16:34:34.129 [ ccube] calc nodes=101334/758106
16:35:22.254 [ ccube] calc depth=1 classes=9415 avgchildren=3.0
16:35:23.848 [ ccube] calc nodes=82674/881186
16:35:24.411 [ ccube] calc depth=2 classes=13 avgchildren=2.0
16:35:24.879 [ ccube] calc nodes=82661/881202
16:35:26.567 [ ccube] calc depth=3 classes=32 avgchildren=2.0
16:35:27.864 [ ccube] calc hierarchy 9
16:35:30.661 [ ccube] calc nodes=82629/881243
16:35:39.379 [ ccube] calc depth=1 classes=1359 avgchildren=2.0
16:35:41.614 [ ccube] calc nodes=163862/890199
16:35:44.067 [ ccube] calc depth=2 classes=50 avgchildren=2.0
16:35:46.957 [ ccube] calc hierarchy 10
16:35:50.411 [ ccube] calc nodes=163812/890472
16:50:24.614 [ ccube] calc depth=1 classes=12571 avgchildren=12.0
16:50:29.411 [ ccube] calc nodes=25117/8688971
17:12:08.223 [ ccube] calc depth=2 classes=3385 avgchildren=3.8
17:12:14.067 [ ccube] calc nodes=15752/19103114
18:12:35.989 [ ccube] calc depth=3 classes=6645 avgchildren=3.7
18:12:47.301 [ ccube] calc nodes=6794/41907707
19:03:50.973 [ ccube] calc depth=4 classes=1829 avgchildren=3.0
19:03:57.051 [ ccube] calc topnodes=10241, dimmax=55141493
19:03:57.051 [ ccube] calc done
19:03:57.551 [ Aggregate] njobs=2
19:03:57.551 [ CCCovStat] start dim=POSITIONS2_COMPOSITE
19:03:57.598 [ CCCovStat] base __XML_GENERATED_12 (9 of 10 in status)
19:03:57.614 [ CCCovStat] base STATUS (30 of 34 in status)
19:03:57.614 [ CCCovStat] base MATURITY_DATE (2996 of 3675 in status)
19:03:57.614 [ CCCovStat] base LINES_OF_BUSINESS (211 of 278 in status)
19:03:57.614 [ CCCovStat] base TRADE_DATE (3623 of 4184 in status)
19:03:57.614 [ CCCovStat] base SETTLEMENT_DATE (3623 of 4208 in status)
19:03:57.629 [ CCCovStat] base __XML_GENERATED_7 (2090 of 2137 in status)
19:03:57.629 [ CCCovStat] base EXPOSURE (10846 of 10871 in status)
19:03:57.629 [ CCCovStat] base SECURITY (20353 of 20526 in status)
19:03:57.629 [ CCCovStat] base COMPLIANCE_RATING (23 of 32 in status)
19:03:57.645 [ CCCovStat] base OWNERSHIP (82599 of 83007 in status)
19:03:57.786 [ CCCovStat] build leafstat
19:04:05.457 [ CCCovStat] finished stlen=443296
19:04:05.457 [ Aggregate] cp2bas dim=0 stlen=443296 stval=-1
19:04:05.457 [ Aggregate] calcstart ndims=3 rudpos=1 depth=3
19:04:05.489 [ Aggregate] aggregate POSITIONS2_PRT_TOPVAR using OBJ993979675 over AS_OF_DATE op HIERARCHICAL-LAST
19:04:05.536 [ Dimen] dim[0]=POSITIONS2_CO stval=-1 stlen=443296 smax=55141493 composite
19:04:05.536 [ Dimen] dim[0]=__XML_GENERAT stval=9 stlen=9 smax=9
19:04:05.551 [ Dimen] dim[1]=STATUS stval=33 stlen=30 smax=33
19:04:05.551 [ Dimen] dim[2]=MATURITY_DATE stval=3674 stlen=2996 smax=3674
19:04:05.551 [ Dimen] dim[3]=LINES_OF_BUSI stval=277 stlen=211 smax=277
19:04:05.551 [ Dimen] dim[4]=TRADE_DATE stval=4183 stlen=3623 smax=4183
19:04:05.551 [ Dimen] dim[5]=SETTLEMENT_DA stval=4207 stlen=3623 smax=4207
19:04:05.551 [ Dimen] dim[6]=__XML_GENERAT stval=2136 stlen=2090 smax=2136
19:04:05.551 [ Dimen] dim[7]=EXPOSURE stval=10870 stlen=10846 smax=10870
19:04:05.551 [ Dimen] dim[8]=SECURITY stval=20525 stlen=20353 smax=20525
19:04:05.551 [ Dimen] dim[9]=COMPLIANCE_RA stval=31 stlen=23 smax=31
19:04:05.551 [ Dimen] dim[10]=OWNERSHIP stval=83006 stlen=82599 smax=83006
19:04:05.551 [ Dimen] dim[1]=AS_OF_DATE stval=38 stlen=39 smax=38
19:04:05.551 [ Dimen] dim[2]=POSITIONS2_PR stval=0 stlen=1 smax=0
19:04:05.567 [ Aggregate] agglen=1
19:04:05.567 [ Aggregate] fastdim=0 maxchsize=1
19:04:05.567 [ AgWlist] Generating worklists
19:04:05.567 [ AgWlist] start=0 end=3 len=3
19:04:05.567 [ AgWlist] done
19:04:05.567 [ Aggregate] wlstats worklist=1 parents=15
19:05:15.707 [ Aggregate] wlstats worklist=2 parents=6
19:06:15.707 [ Aggregate] wlstats worklist=3 parents=3
19:07:12.864 [ Aggregate] calcstart ndims=3 rudpos=0 depth=80
19:07:12.879 [ CCCovStat] start dim=POSITIONS2_COMPOSITE
19:07:12.942 [ CCCovStat] base __XML_GENERATED_12 (9 of 10 in status)
19:07:12.942 [ CCCovStat] base STATUS (30 of 34 in status)
19:07:12.942 [ CCCovStat] base MATURITY_DATE (2996 of 3675 in status)
19:07:12.957 [ CCCovStat] base LINES_OF_BUSINESS (211 of 278 in status)
19:07:12.957 [ CCCovStat] base TRADE_DATE (3623 of 4184 in status)
19:07:12.973 [ CCCovStat] base SETTLEMENT_DATE (3623 of 4208 in status)
19:07:13.051 [ CCCovStat] base __XML_GENERATED_7 (2090 of 2137 in status)
19:07:13.114 [ CCCovStat] base EXPOSURE (10846 of 10871 in status)
19:07:13.161 [ CCCovStat] base SECURITY (20353 of 20526 in status)
19:07:13.270 [ CCCovStat] base COMPLIANCE_RATING (23 of 32 in status)
19:07:13.270 [ CCCovStat] base OWNERSHIP (82599 of 83007 in status)
19:07:13.504 [ CCCovStat] build leafstat
19:07:21.629 [ CCCovStat] finished stlen=443296
19:07:22.176 [ CCCovStat] start dim=POSITIONS2_COMPOSITE
19:07:22.207 [ CCCovStat] base __XML_GENERATED_12 (10 of 10 in status)
19:07:22.223 [ CCCovStat] base STATUS (34 of 34 in status)
19:07:22.239 [ CCCovStat] base MATURITY_DATE (3675 of 3675 in status)
19:07:22.254 [ CCCovStat] base LINES_OF_BUSINESS (278 of 278 in status)
19:07:22.270 [ CCCovStat] base TRADE_DATE (4184 of 4184 in status)
19:07:22.286 [ CCCovStat] base SETTLEMENT_DATE (4208 of 4208 in status)
19:07:22.301 [ CCCovStat] base __XML_GENERATED_7 (2137 of 2137 in status)
19:07:22.317 [ CCCovStat] base EXPOSURE (10871 of 10871 in status)
19:07:22.332 [ CCCovStat] base SECURITY (20526 of 20526 in status)
19:07:22.332 [ CCCovStat] base COMPLIANCE_RATING (32 of 32 in status)
19:07:22.332 [ CCCovStat] base OWNERSHIP (83007 of 83007 in status)
19:07:22.348 [ CCCovStat] build allstat
19:08:35.754 [ Cmp2Bases] Created ALL status for POSITIONS2_COMPOSITE with 55141494 values
19:08:35.770 [ CCCovStat] finished stlen=55141494
19:08:35.770 [ Aggregate] aggregate POSITIONS2_PRT_TOPVAR using OBJ993979675 over POSITIONS2_COMPOSITE op SUM
19:08:35.770 [ Dimen] dim[0]=POSITIONS2_CO stval=-1 stlen=55141494 smax=55141493 composite
19:08:35.770 [ Dimen] dim[0]=__XML_GENERAT stval=9 stlen=10 smax=9
19:08:35.770 [ Dimen] dim[1]=STATUS stval=33 stlen=34 smax=33
19:08:35.770 [ Dimen] dim[2]=MATURITY_DATE stval=3674 stlen=3675 smax=3674
19:08:35.770 [ Dimen] dim[3]=LINES_OF_BUSI stval=277 stlen=278 smax=277
19:08:35.770 [ Dimen] dim[4]=TRADE_DATE stval=4183 stlen=4184 smax=4183
19:08:35.770 [ Dimen] dim[5]=SETTLEMENT_DA stval=4207 stlen=4208 smax=4207
19:08:35.770 [ Dimen] dim[6]=__XML_GENERAT stval=2136 stlen=2137 smax=2136
19:08:35.770 [ Dimen] dim[7]=EXPOSURE stval=10870 stlen=10871 smax=10870
19:08:35.770 [ Dimen] dim[8]=SECURITY stval=20525 stlen=20526 smax=20525
19:08:35.770 [ Dimen] dim[9]=COMPLIANCE_RA stval=31 stlen=32 smax=31
19:08:35.770 [ Dimen] dim[10]=OWNERSHIP stval=83006 stlen=83007 smax=83006
19:08:35.770 [ Dimen] dim[1]=AS_OF_DATE stval=2 stlen=39 smax=38
19:08:35.801 [ Dimen] dim[2]=POSITIONS2_PR stval=0 stlen=1 smax=0
19:08:35.801 [ Aggregate] agglen=39
19:08:35.801 [ Aggregate] fastdim=0 maxchsize=39
19:08:35.801 [ Aggregate] fastdim=1 maxchsize=1
19:08:35.801 [ AgWlist] Generating worklists
19:08:35.801 [ AgWlist] start=0 end=80 len=80
19:09:52.832 [ AgWlist] done
19:09:52.832 [ Aggregate] wlstats worklist=1 parents=5704
19:09:57.770 [ Aggregate] wlstats worklist=2 parents=5060
19:10:02.551 [ Aggregate] wlstats worklist=3 parents=86862
19:10:38.301 [ Aggregate] wlstats worklist=4 parents=51235
19:11:17.176 [ Aggregate] wlstats worklist=5 parents=107878
19:12:58.661 [ Aggregate] wlstats worklist=6 parents=36236
19:14:03.895 [ Aggregate] wlstats worklist=7 parents=15633
19:14:25.176 [ Aggregate] wlstats worklist=8 parents=2919
19:14:26.911 [ Aggregate] wlstats worklist=9 parents=340
19:14:27.004 [ Aggregate] wlstats worklist=10 parents=23
19:14:27.020 [ Aggregate] wlstats worklist=11 parents=136
19:14:27.207 [ Aggregate] wlstats worklist=12 parents=4
19:14:27.207 [ Aggregate] wlstats worklist=13 parents=505
19:14:27.536 [ Aggregate] wlstats worklist=14 parents=2
19:14:27.536 [ Aggregate] wlstats worklist=15 parents=155
19:14:27.770 [ Aggregate] wlstats worklist=16 parents=473
19:14:28.082 [ Aggregate] wlstats worklist=17 parents=20
19:14:28.082 [ Aggregate] wlstats worklist=18 parents=5
19:14:28.098 [ Aggregate] wlstats worklist=19 parents=1014
19:14:28.707 [ Aggregate] wlstats worklist=20 parents=90
19:14:28.723 [ Aggregate] wlstats worklist=21 parents=19
19:14:28.723 [ Aggregate] wlstats worklist=22 parents=389
19:14:29.036 [ Aggregate] wlstats worklist=23 parents=12
19:14:29.067 [ Aggregate] wlstats worklist=24 parents=92
19:14:29.223 [ Aggregate] wlstats worklist=25 parents=4
19:14:29.223 [ Aggregate] wlstats worklist=26 parents=108719
19:16:37.332 [ Aggregate] wlstats worklist=27 parents=11592
19:16:58.020 [ Aggregate] wlstats worklist=28 parents=2753
19:17:08.411 [ Aggregate] wlstats worklist=29 parents=16
19:17:08.739 [ Aggregate] wlstats worklist=30 parents=16
19:17:08.817 [ Aggregate] wlstats worklist=31 parents=41
19:17:09.082 [ Aggregate] wlstats worklist=32 parents=8486
19:17:16.411 [ Aggregate] wlstats worklist=33 parents=396
19:17:16.629 [ Aggregate] wlstats worklist=34 parents=68
19:17:16.645 [ Aggregate] wlstats worklist=35 parents=6
19:17:16.645 [ Aggregate] wlstats worklist=36 parents=258
19:17:16.723 [ Aggregate] wlstats worklist=37 parents=12
19:17:16.739 [ Aggregate] wlstats worklist=38 parents=3
19:17:16.739 [ Aggregate] wlstats worklist=39 parents=4016805
19:47:21.989 [ Aggregate] wlstats worklist=40 parents=2322919
20:14:22.661 [ Aggregate] wlstats worklist=41 parents=1008803
20:36:36.879 [ Aggregate] wlstats worklist=42 parents=333714
20:49:24.801 [ Aggregate] wlstats worklist=43 parents=90024
20:55:40.114 [ Aggregate] wlstats worklist=44 parents=20086
20:57:53.911 [ Aggregate] wlstats worklist=45 parents=4605
20:58:24.848 [ Aggregate] wlstats worklist=46 parents=1194
20:58:36.145 [ Aggregate] wlstats worklist=47 parents=281
20:58:36.973 [ Aggregate] wlstats worklist=48 parents=64
20:58:37.239 [ Aggregate] wlstats worklist=49 parents=4
20:58:37.286 [ Aggregate] wlstats worklist=50 parents=5038548
21:43:04.364 [ Aggregate] wlstats worklist=51 parents=3195811
22:24:27.582 [ Aggregate] wlstats worklist=52 parents=1429880
22:49:59.754 [ Aggregate] wlstats worklist=53 parents=517557
23:07:10.395 [ Aggregate] wlstats worklist=54 parents=169518
23:16:41.254 [ Aggregate] wlstats worklist=55 parents=48159
23:21:19.661 [ Aggregate] wlstats worklist=56 parents=11725
23:23:04.442 [ Aggregate] wlstats worklist=57 parents=2434
23:23:31.364 [ Aggregate] wlstats worklist=58 parents=453
23:23:36.551 [ Aggregate] wlstats worklist=59 parents=55
23:23:37.129 [ Aggregate] wlstats worklist=60 parents=3
23:23:37.207 [ Aggregate] wlstats worklist=61 parents=10862772
00:32:28.036 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675 clean=session
00:34:45.528 [ AgClean] finish clean=session
08:50:50.068 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675_PRT_PRTAGGMAP clean=memory
08:50:50.083 [ AgClean] finish clean=memory
08:50:50.083 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675_PRT_RUNAGGMAP clean=memory
08:50:50.099 [ AgClean] finish clean=memory
08:50:50.099 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675_PRT_TOPAGGMAP clean=memory
08:50:50.115 [ AgClean] finish clean=memory
08:50:50.130 [ AgClean] start aggmap=TEST_RISKMGMT!OBJ993979675 clean=memory
08:50:50.130 [ AgClean] finish clean=memory
SESSION DIED HERE WITH OUT OF SPACE ON SERVER
08:50:52.615 [ SessCache] Destroying sesscache on TEST_RISKMGMT!AS_OF_DATE_SHORT_DESCRIPTION
08:50:52.615 [ SessCache] Destroying sesscache on TEST_RISKMGMT!AS_OF_DATE_LONG_DESCRIPTION
08:50:52.646 [ SessCache] Destroying sesscache on TEST_RISKMGMT!AS_OF_DATE_GID
08:50:52.646 [ SessCache] Destroying sesscache on TEST_RISKMGMT!AS_OF_DATE_FAMILYREL
08:50:52.646 [ SessCache] Destroying sesscache on TEST_RISKMGMT!AS_OF_DATE_PARENTREL