Check that analyze_data_online makes good histos for full run ... Error in <TH1F::KolmogorovTest>: Histogram2 ht01 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 spx0 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 spy0 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 htof integral is zero

Error in <TH2F::KolmogorovTest>: Integral is zero for h2=tof_A

Error in <TH2F::KolmogorovTest>: Integral is zero for h2=tof_B

Error in <TH1F::KolmogorovTest>: Histogram2 hPMT1 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 hPMT2 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 hPMT3 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 hPMT4 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 hPMT5 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 hPMT6 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 hPMT7 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 hPMT8 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 harr_time1 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 harr_time2 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 harr_time3 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 harr_time4 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 harr_time5 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 harr_time6 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 harr_time7 integral is zero

Error in <TH1F::KolmogorovTest>: Histogram2 harr_time8 integral is zero

FAIL

Check that the default parameters produce sensible output ... Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

WARNING : The first event is not a START_OF_RUN. Spill count and Event count not accurate. 

Written 1 event(s) to file.

Written 1 event(s) to file.

>Server:  MICE Production Server - Public read only interface 1.0.0.0

Welcome to MAUS:

	Process ID (PID): 9946

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/analyze_data_offline.py', '-output_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_analyze_data_offline.root']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 8 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 9 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 10 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 11 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 12 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 13 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 14 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 15 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 16 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 17 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 18 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 19 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 20 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

Written 19 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

TRANSFORM/MERGE/OUTPUT:  Processed 21 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 22 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 23 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 24 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 25 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 26 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Failed to find event 1 in file.

Failed to find event 1 in file.

Failed to find event 19 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Welcome to MAUS:

	Process ID (PID): 10002

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/utilities/root_to_json.py', '-input_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_analyze_data_offline.root', '-output_json_file_name', '/home/mice/MAUS/.maus_release/tmp/test_analyze_data_offline.json']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 8 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 9 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 10 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 11 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 12 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 13 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 14 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 15 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 16 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 17 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 18 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 19 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 20 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 21 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 22 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 23 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

ok

[2014-02-04 11:14:15,219: WARNING/MainProcess] discard: Erased 0 message from the queue.

[2014-02-04 11:14:15,221: WARNING/MainProcess] -------------- celery@miceonrec02a.micenet.rl.ac.uk v2.5.5

---- **** -----

--- * ***  * -- [Configuration]

-- * - **** ---   . broker:      amqp://maus@localhost:5672/maushost

- ** ----------   . loader:      celery.loaders.default.Loader

- ** ----------   . logfile:     [stderr]@INFO

- ** ----------   . concurrency: 2

- ** ----------   . events:      OFF

- *** --- * ---   . beat:        OFF

-- ******* ----

--- ***** ----- [Queues]

 --------------   . celery:      exchange:celery (direct) binding:celery

[Tasks]

  . mauscelery.maustasks.MausGenericTransformTask

[2014-02-04 11:14:15,244: INFO/MainProcess] MAUS version: MAUS release version 0.7.3

[2014-02-04 11:14:15,258: INFO/PoolWorker-1] child process calling self.run()

[2014-02-04 11:14:15,260: INFO/PoolWorker-1] Setting MAUS ErrorHandler to raise exceptions

[2014-02-04 11:14:15,256: INFO/PoolWorker-2] child process calling self.run()

[2014-02-04 11:14:15,257: WARNING/MainProcess] celery@miceonrec02a.micenet.rl.ac.uk has started.

[2014-02-04 11:14:15,258: INFO/PoolWorker-2] Setting MAUS ErrorHandler to raise exceptions

Test birth broadcast command. ... Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:18,482: INFO/MainProcess] Birthing transform MapPyPrint

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:18,547: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:14:18,547: INFO/PoolWorker-1] Birthing transform MapPyPrint

[2014-02-04 11:14:18,548: INFO/PoolWorker-1] Finished birthing transforms MapPyPrint

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:18,602: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:14:18,603: INFO/PoolWorker-2] Birthing transform MapPyPrint

[2014-02-04 11:14:18,603: INFO/PoolWorker-2] Finished birthing transforms MapPyPrint

[2014-02-04 11:14:18,604: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 11:14:22,640: INFO/MainProcess] Birthing transform MapPyPrint

[2014-02-04 11:14:22,647: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:14:22,648: INFO/PoolWorker-1] Birthing transform MapPyPrint

[2014-02-04 11:14:22,648: INFO/PoolWorker-1] Finished birthing transforms MapPyPrint

[2014-02-04 11:14:22,644: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:14:22,645: INFO/PoolWorker-2] Birthing transform MapPyPrint

[2014-02-04 11:14:22,645: INFO/PoolWorker-2] Finished birthing transforms MapPyPrint

[2014-02-04 11:14:22,646: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

ok

Test birth broadcast command with an invalid JSON ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:29,749: INFO/MainProcess] Birthing transform MapPyPrint

[2014-02-04 11:14:29,749: INFO/MainProcess] Status: {'status': 'error', 'run_headers': '', 'error': [{'message': 'No JSON object could be decoded', 'error': "<type 'exceptions.ValueError'>"}]}

ok

Test birth broadcast command with an invalid transform name. ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:34,830: INFO/MainProcess] Birthing transform MapPyUnknown

[2014-02-04 11:14:34,831: INFO/MainProcess] Status: {'status': 'error', 'run_headers': '', 'error': [{'message': 'No such transform: MapPyUnknown', 'error': "<type 'exceptions.ValueError'>"}]}

ok

Test birth broadcast command with a mismatched MAUS version. ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:39,911: INFO/MainProcess] Birthing transform MapPyPrint

[2014-02-04 11:14:39,911: INFO/MainProcess] Status: {'status': 'error', 'run_headers': '', 'error': [{'message': 'maus_version: expected MAUS release version 0.7.3, got BAD', 'error': "<type 'exceptions.ValueError'>"}]}

ok

Test birth broadcast command where the transform returns ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:44,988: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 11:14:44,995: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:14:44,996: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 11:14:44,993: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:14:44,994: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 11:14:44,995: INFO/MainProcess] Status: {'status': 'error', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}'], 'error': [{'message': 'Birth exception', 'error': "<type 'exceptions.ValueError'>"}]}

ok

Test death broadcast command. ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:50,081: INFO/MainProcess] Deathing transform

[2014-02-04 11:14:50,083: INFO/MainProcess] Status: {'status': 'ok', 'run_footers': []}

[2014-02-04 11:14:52,094: INFO/MainProcess] Deathing transform

[2014-02-04 11:14:52,095: INFO/MainProcess] Status: {'status': 'ok', 'run_footers': []}

ok

Test death broadcast command where the transform returns ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:14:57,187: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 11:14:57,192: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:14:57,193: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 11:14:57,193: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 11:14:57,189: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:14:57,190: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 11:14:57,190: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 11:14:57,191: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 11:14:59,208: INFO/MainProcess] Birthing transform MapPyDoNothing

[2014-02-04 11:14:59,214: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:14:59,215: INFO/PoolWorker-1] Birthing transform MapPyDoNothing

[2014-02-04 11:14:59,211: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:14:59,212: INFO/PoolWorker-2] Birthing transform MapPyDoNothing

[2014-02-04 11:14:59,212: INFO/MainProcess] Status: {'status': 'error', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}'], 'error': [{'message': 'Death exception', 'error': "<type 'exceptions.ValueError'>"}]}

[2014-02-04 11:15:01,227: INFO/MainProcess] Birthing transform MapPyDoNothing

[2014-02-04 11:15:01,233: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:15:01,233: INFO/PoolWorker-1] Birthing transform MapPyDoNothing

[2014-02-04 11:15:01,233: INFO/PoolWorker-1] Finished birthing transforms MapPyDoNothing

[2014-02-04 11:15:01,229: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:15:01,230: INFO/PoolWorker-2] Birthing transform MapPyDoNothing

[2014-02-04 11:15:01,230: INFO/PoolWorker-2] Finished birthing transforms MapPyDoNothing

[2014-02-04 11:15:01,230: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

ok

Test death broadcast command where the transform throws ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:15:08,331: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 11:15:08,336: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:15:08,337: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 11:15:08,338: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:08,334: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:15:08,334: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 11:15:08,335: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:08,335: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 11:15:10,351: INFO/MainProcess] Deathing transform

[2014-02-04 11:15:10,356: INFO/PoolWorker-1] Deathing transform 1

[2014-02-04 11:15:10,352: INFO/PoolWorker-2] Deathing transform 1

[2014-02-04 11:15:10,353: INFO/MainProcess] Status: {'status': 'error', 'run_footers': [], 'error': [{'message': 'Death exception', 'error': "<type 'exceptions.ValueError'>"}]}

[2014-02-04 11:15:12,365: INFO/MainProcess] Deathing transform

[2014-02-04 11:15:12,366: INFO/MainProcess] Status: {'status': 'ok', 'run_footers': []}

ok

Test process command. ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:15:17,450: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 11:15:17,455: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:15:17,456: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 11:15:17,456: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:17,453: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:15:17,453: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 11:15:17,453: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:17,454: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 11:15:19,469: INFO/MainProcess] Got task from broker: mauscelery.maustasks.MausGenericTransformTask[715f7386-b4ea-4bca-aeb8-e7c24fe18d5a]

[2014-02-04 11:15:19,496: INFO/PoolWorker-1] None[715f7386-b4ea-4bca-aeb8-e7c24fe18d5a]: Task invoked by 1

[2014-02-04 11:15:19,505: INFO/MainProcess] Task mauscelery.maustasks.MausGenericTransformTask[715f7386-b4ea-4bca-aeb8-e7c24fe18d5a] succeeded in 0.00966000556946s: '{"processed": [""]}'

ok

Test process command fails after death has been called. ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:15:22,573: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 11:15:22,573: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:15:22,574: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 11:15:22,575: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:22,580: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:15:22,581: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 11:15:22,581: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:22,577: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 11:15:24,594: INFO/MainProcess] Deathing transform

[2014-02-04 11:15:24,595: INFO/PoolWorker-2] Deathing transform 1

[2014-02-04 11:15:24,600: INFO/PoolWorker-1] Deathing transform 1

[2014-02-04 11:15:24,597: INFO/MainProcess] Status: {'status': 'ok', 'run_footers': ['{"maus_event_type":"RunFooter","run_number":1}', '{"maus_event_type":"RunFooter","run_number":1}']}

[2014-02-04 11:15:26,610: INFO/MainProcess] Got task from broker: mauscelery.maustasks.MausGenericTransformTask[348f1a11-502c-4515-8347-ee8a8fd1b198]

[2014-02-04 11:15:26,661: INFO/PoolWorker-2] None[348f1a11-502c-4515-8347-ee8a8fd1b198]: Task invoked by 1

[2014-02-04 11:15:26,676: ERROR/MainProcess] Task mauscelery.maustasks.MausGenericTransformTask[348f1a11-502c-4515-8347-ee8a8fd1b198] raised exception: UnpickleableExceptionWrapper('framework.workers', 'WorkerProcessException', (), 'WorkerProcessException()')

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/celery-2.5.5-py2.7.egg/celery/execute/trace.py", line 181, in trace_task

    R = retval = fun(*args, **kwargs)

  File "/home/mice/MAUS/.maus_release/src/common_py/mauscelery/tasks.py", line 64, in execute_transform

    status)

WorkerProcessException: WorkerProcessException()

ok

Test process timeout. ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

[2014-02-04 11:15:29,752: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 11:15:29,758: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:15:29,759: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 11:15:29,760: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:29,756: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:15:29,757: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 11:15:29,758: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:29,759: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 11:15:31,769: INFO/MainProcess] Got task from broker: mauscelery.maustasks.MausGenericTransformTask[f35ec430-04e9-491f-bac4-7bfedefb5c8f]

[2014-02-04 11:15:31,782: INFO/PoolWorker-1] None[f35ec430-04e9-491f-bac4-7bfedefb5c8f]: Task invoked by 1

[2014-02-04 11:15:31,782: WARNING/PoolWorker-1] Sleeping for

[2014-02-04 11:15:31,782: WARNING/PoolWorker-1] 9.0

[2014-02-04 11:15:31,782: WARNING/PoolWorker-1] seconds

[2014-02-04 11:15:40,787: INFO/MainProcess] Task mauscelery.maustasks.MausGenericTransformTask[f35ec430-04e9-491f-bac4-7bfedefb5c8f] succeeded in 9.00567412376s: '{"processed": [""]}'

[2014-02-04 11:15:40,795: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 11:15:40,797: INFO/PoolWorker-2] Start of run action

[2014-02-04 11:15:40,797: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 11:15:40,799: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:40,804: INFO/PoolWorker-1] Start of run action

[2014-02-04 11:15:40,805: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 11:15:40,806: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 11:15:40,801: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 11:15:42,812: INFO/MainProcess] Got task from broker: mauscelery.maustasks.MausGenericTransformTask[ab83b593-6b2e-4c22-9d8e-adfd4b0e84ba]

[2014-02-04 11:15:42,820: INFO/PoolWorker-2] None[ab83b593-6b2e-4c22-9d8e-adfd4b0e84ba]: Task invoked by 1

[2014-02-04 11:15:42,821: WARNING/PoolWorker-2] Sleeping for

[2014-02-04 11:15:42,821: WARNING/PoolWorker-2] 15.0

[2014-02-04 11:15:42,821: WARNING/PoolWorker-2] seconds

[2014-02-04 11:15:53,492: ERROR/MainProcess] Task mauscelery.maustasks.MausGenericTransformTask[ab83b593-6b2e-4c22-9d8e-adfd4b0e84ba] raised exception: TimeLimitExceeded(10,)

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/celery-2.5.5-py2.7.egg/celery/concurrency/processes/pool.py", line 370, in _on_hard_timeout

    raise TimeLimitExceeded(hard_timeout)

TimeLimitExceeded: 10

[2014-02-04 11:15:53,493: ERROR/MainProcess] Hard time limit (10s) exceeded for mauscelery.maustasks.MausGenericTransformTask[ab83b593-6b2e-4c22-9d8e-adfd4b0e84ba]

 *** Break *** write on a pipe with no one to read it

[2014-02-04 11:15:53,494: WARNING/MainProcess] Couldn't send result for 'ab83b593-6b2e-4c22-9d8e-adfd4b0e84ba': error(32, 'Broken pipe'). Retry in 0s.

[2014-02-04 11:15:53,506: ERROR/MainProcess] Consumer: Connection to broker lost. Trying to re-establish the connection...

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/celery-2.5.5-py2.7.egg/celery/worker/consumer.py", line 337, in start

    self.consume_messages()

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/celery-2.5.5-py2.7.egg/celery/worker/consumer.py", line 353, in consume_messages

    self.connection.drain_events(timeout=1)

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/kombu-2.1.8-py2.7.egg/kombu/connection.py", line 167, in drain_events

    return self.transport.drain_events(self.connection, **kwargs)

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/kombu-2.1.8-py2.7.egg/kombu/transport/amqplib.py", line 262, in drain_events

    return connection.drain_events(**kwargs)

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/kombu-2.1.8-py2.7.egg/kombu/transport/amqplib.py", line 94, in drain_events

    return self.wait_multi(self.channels.values(), timeout=timeout)

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/kombu-2.1.8-py2.7.egg/kombu/transport/amqplib.py", line 100, in wait_multi

    chanmap.keys(), allowed_methods, timeout=timeout)

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/kombu-2.1.8-py2.7.egg/kombu/transport/amqplib.py", line 159, in _wait_multiple

    channel, method_sig, args, content = read_timeout(timeout)

  File "/home/mice/MAUS/.maus_release/third_party/install/lib/python2.7/site-packages/kombu-2.1.8-py2.7.egg/kombu/transport/amqplib.py", line 132, in read_timeout

    return self.method_reader.read_method()

  File "build/bdist.linux-x86_64/egg/amqplib/client_0_8/method_framing.py", line 221, in read_method

    raise m

error: [Errno 4] Interrupted system call

ok

[2014-02-04 11:15:53,522: INFO/PoolWorker-1] process shutting down

[2014-02-04 11:15:53,522: INFO/PoolWorker-1] process exiting with exitcode 0

Get everything in bin/examples and check it runs with returncode 0 ... Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 46, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 52, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples/configuration_db_example'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 46, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 52, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples/simple_scalers_example'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 46, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 52, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples/make_field_map'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 46, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 52, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples/load_json_file'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 46, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples'

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_examples/test_examples.py", line 52, in move_images

    os.mkdir(plot_dir)

OSError: [Errno 17] File exists: '/home/mice/MAUS/.maus_release/tests/integration/plots/examples/load_root_file'

rm load_root_file;

rm *.png;

Running with /home/mice/MAUS/.maus_release on 

Linux miceonrec02a.micenet.rl.ac.uk 2.6.18-274.el5 #1 SMP Thu Jul 21 12:13:11 EDT 2011 x86_64 x86_64 x86_64 GNU/Linux

g++ load_root_file.cc -o load_root_file \

	                      -I/home/mice/MAUS/.maus_release/ \

	                      -I/home/mice/MAUS/.maus_release/src/common_cpp \

	                      -I/home/mice/MAUS/.maus_release/src/legacy \

	                      -I/home/mice/MAUS/.maus_release/third_party/install/include \

	                      -I/home/mice/MAUS/.maus_release/third_party/build/root_v5.34.07/include \

	                      -L/home/mice/MAUS/.maus_release/build/ \

	                      `root-config --ldflags` \

	                      `/home/mice/MAUS/.maus_release/third_party/build/root_v5.34.07/bin/root-config --glibs` \

	                      -lMausCpp \

	                       -Wl,--no-as-needed

Warning in <TUnixSystem::SetDisplay>: DISPLAY not set, setting it to isis5817.sci.rl.ac.uk:0.0

ok

Check that we can calculate optics beta function correctly; plot output ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,-5250) rotationVector: (0,0,1) angle: 0 name: Field1

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,-4500) rotationVector: (0,0,1) angle: 0 name: Field2

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,-3750) rotationVector: (0,0,1) angle: 0 name: Field3

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,-3000) rotationVector: (0,0,1) angle: 0 name: Field4

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,-2250) rotationVector: (0,0,1) angle: 0 name: Field5

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,-1500) rotationVector: (0,0,1) angle: 0 name: Field6

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,-750) rotationVector: (0,0,1) angle: 0 name: Field7

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,0) rotationVector: (0,0,1) angle: 0 name: Field8

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,750) rotationVector: (0,0,1) angle: 0 name: Field9

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,1500) rotationVector: (0,0,1) angle: 0 name: Field10

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,2250) rotationVector: (0,0,1) angle: 0 name: Field11

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,3000) rotationVector: (0,0,1) angle: 0 name: Field12

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,3750) rotationVector: (0,0,1) angle: 0 name: Field13

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,4500) rotationVector: (0,0,1) angle: 0 name: Field14

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,5250) rotationVector: (0,0,1) angle: 0 name: Field15

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,6000) rotationVector: (0,0,1) angle: 0 name: Field16

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,6750) rotationVector: (0,0,1) angle: 0 name: Field17

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,7500) rotationVector: (0,0,1) angle: 0 name: Field18

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,8250) rotationVector: (0,0,1) angle: 0 name: Field19

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,9000) rotationVector: (0,0,1) angle: 0 name: Field20

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,9750) rotationVector: (0,0,1) angle: 0 name: Field21

Looking for optimisation requests

Running beam envelope through

Finding TrackingDerivative envelope functions

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

done

Info in <TCanvas::Print>: png file /home/mice/MAUS/.maus_release/tests/integration/plots/optics/mapping_optics.png has been created

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,-5250) rotationVector: (0,0,1) angle: 0 name: Field1

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,-4500) rotationVector: (0,0,1) angle: 0 name: Field2

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,-3750) rotationVector: (0,0,1) angle: 0 name: Field3

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,-3000) rotationVector: (0,0,1) angle: 0 name: Field4

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,-2250) rotationVector: (0,0,1) angle: 0 name: Field5

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,-1500) rotationVector: (0,0,1) angle: 0 name: Field6

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,-750) rotationVector: (0,0,1) angle: 0 name: Field7

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,0) rotationVector: (0,0,1) angle: 0 name: Field8

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,750) rotationVector: (0,0,1) angle: 0 name: Field9

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,1500) rotationVector: (0,0,1) angle: 0 name: Field10

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,2250) rotationVector: (0,0,1) angle: 0 name: Field11

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,3000) rotationVector: (0,0,1) angle: 0 name: Field12

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,3750) rotationVector: (0,0,1) angle: 0 name: Field13

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,4500) rotationVector: (0,0,1) angle: 0 name: Field14

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,5250) rotationVector: (0,0,1) angle: 0 name: Field15

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,6000) rotationVector: (0,0,1) angle: 0 name: Field16

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,6750) rotationVector: (0,0,1) angle: 0 name: Field17

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,7500) rotationVector: (0,0,1) angle: 0 name: Field18

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,8250) rotationVector: (0,0,1) angle: 0 name: Field19

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: -106.66 position: (0,0,9000) rotationVector: (0,0,1) angle: 0 name: Field20

Solenoid Length: 150 Inner Radius: 350 Thickness: 150 Current Density: 1  scaleFactor: 106.66 position: (0,0,9750) rotationVector: (0,0,1) angle: 0 name: Field21

Looking for optimisation requests

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

@Beta_T: 750  ** Score1: 28272.9 Score2: 100.169  ** Total: 28373

@Beta_T: 759.978  ** Score1: 33951.3 Score2: 120.214  ** Total: 34071.5

@Beta_T: 745.997  ** Score1: 26123.7 Score2: 92.5806  ** Total: 26216.3

@Beta_T: 733.946  ** Score1: 20114.8 Score2: 71.3575  ** Total: 20186.1

@Beta_T: 697.482  ** Score1: 6413.16 Score2: 22.8962  ** Total: 6436.06

@Beta_T: 586.504  ** Score1: 16716.5 Score2: 58.2668  ** Total: 16774.8

@Beta_T: 644.214  ** Score1: 250.37 Score2: 0.816117  ** Total: 251.186

@Beta_T: 590.627  ** Score1: 14591.8 Score2: 50.8281  ** Total: 14642.6

@Beta_T: 590.627  ** Score1: 14591.8 Score2: 50.8281  ** Total: 14642.6

@Beta_T: 670.915  ** Score1: 1100.68 Score2: 4.0115  ** Total: 1104.69

@Beta_T: 617.433  ** Score1: 4499.98 Score2: 15.5519  ** Total: 4515.53

@Beta_T: 657.578  ** Score1: 80.0686 Score2: 0.320164  ** Total: 80.3887

@Beta_T: 670.915  ** Score1: 1100.68 Score2: 4.0115  ** Total: 1104.69

@Beta_T: 650.898  ** Score1: 11.3457 Score2: 0.0271198  ** Total: 11.3728

@Beta_T: 644.214  ** Score1: 250.37 Score2: 0.816117  ** Total: 251.186

@Beta_T: 654.239  ** Score1: 7.87927 Score2: 0.0406385  ** Total: 7.91991

@Beta_T: 657.578  ** Score1: 80.0686 Score2: 0.320164  ** Total: 80.3887

@Beta_T: 652.569  ** Score1: 0.0763787 Score2: 0.000350043  ** Total: 0.0767287

@Beta_T: 650.898  ** Score1: 11.3457 Score2: 0.0271198  ** Total: 11.3728

@Beta_T: 653.404  ** Score1: 1.60375 Score2: 0.012147  ** Total: 1.61589

@Beta_T: 651.734  ** Score1: 3.31704 Score2: 0.00531759  ** Total: 3.32236

@Beta_T: 652.986  ** Score1: 0.245303 Score2: 0.00415732  ** Total: 0.24946

@Beta_T: 652.151  ** Score1: 1.09946 Score2: 0.000733881  ** Total: 1.10019

@Beta_T: 652.778  ** Score1: 0.0119955 Score2: 0.00173034  ** Total: 0.0137258

@Beta_T: 652.986  ** Score1: 0.245303 Score2: 0.00415732  ** Total: 0.24946

@Beta_T: 652.673  ** Score1: 0.00695634 Score2: 0.000909286  ** Total: 0.00786563

@Beta_T: 652.569  ** Score1: 0.0763787 Score2: 0.000350043  ** Total: 0.0767287

@Beta_T: 652.725  ** Score1: 0.000170663 Score2: 0.00128709  ** Total: 0.00145776

@Beta_T: 652.778  ** Score1: 0.0119955 Score2: 0.00173034  ** Total: 0.0137258

@Beta_T: 652.699  ** Score1: 0.00123689 Score2: 0.00109001  ** Total: 0.0023269

@Beta_T: 652.751  ** Score1: 0.00375707 Score2: 0.00150054  ** Total: 0.0052576

@Beta_T: 652.712  ** Score1: 0.000122158 Score2: 0.00118651  ** Total: 0.00130867

@Beta_T: 652.712  ** Score1: 0.000122158 Score2: 0.00118651  ** Total: 0.00130867

Running beam envelope through

Finding TrackingDerivative envelope functions

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

done

Info in <TCanvas::Print>: png file /home/mice/MAUS/.maus_release/tests/integration/plots/optics/optimiser_optics.png has been created

ok

Check that we have coloured particles ... ok

Check that we have accumulated particles ... ok

Check that we can generate a binomial distribution for event number ... Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Written 1 event(s) to file.

Written 1 event(s) to file.

Written 101 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Failed to find event 1 in file.

Failed to find event 1 in file.

Failed to find event 101 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Written 1 event(s) to file.

Written 1 event(s) to file.

Written 1001 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Failed to find event 1 in file.

Failed to find event 1 in file.

Failed to find event 1001 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Written 1 event(s) to file.

Written 1 event(s) to file.

Written 2 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Failed to find event 1 in file.

Failed to find event 1 in file.

Failed to find event 2 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Info in <TCanvas::Print>: png file /home/mice/MAUS/.maus_release/tests/integration/plots/beam_maker/binomial_distribution_test.png has been created

ok

Check that the default beam parameters run and produce some number of ... ok

Check that the weight of each sub-beam is close to the expected weight ... ok

Check that no nans appear ... Info in <TCanvas::Print>: png file /home/mice/MAUS/.maus_release/tests/integration/plots/beam_maker/nan_energy_distribution_test.png has been created

ok

Check that beam maker generates sawtooth t distribution correctly ... Info in <TCanvas::Print>: png file /home/mice/MAUS/.maus_release/tests/integration/plots/beam_maker/sawtooth_time_distribution_test.png has been created

ok

Check that beam maker generates uniform t distribution correctly ... Info in <TCanvas::Print>: png file /home/mice/MAUS/.maus_release/tests/integration/plots/beam_maker/uniform_time_distribution_test.png has been created

ok

Check that the weight of each sub-beam is close to the expected weight ... ok

For each "Configuration" file, check that we can load it - by calling ... ok

Checks that no other program is grabbing the MAUS help function ... ok

Check that we generate some useful error messages when running ... ok

Check that we can disable particle decay ... ok

Check physics_processes datacard works okay ... ok

Check that reference_physics_processes works okay ... ok

Check that we can set the stepping algorithm okay in Geant4 ... ok

Check that we can run the simulation, make plots ... ok

Run simulation and time execution time. ... ok

Test that the GRID batch script works ... FAIL

Check that get_beamline_info outputs the info by dates ... ok

Check that get_beamline_info outputs the info by dates ... ok

Check that get_beamline_info outputs the info by run ... ok

Check that get_geometry_ids creates a file with the correct geoms ... Server status is OK

File saved to /home/mice/MAUS/.maus_release/tmp/geometry_ids.txt

ok

Check that get_geometry_ids outputs the geometries ... Server status is OK

File saved to /home/mice/MAUS/.maus_release/tmp/geometry_ids.txt

ok

Check json browser --input-file, --output-file, --indent, -l ... ok

Check json browser -L ... ok

Check json browser --start-line, --end-line ... ok

Check that we can run the offline analysis, convert to root, convert ... Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

WARNING : The first event is not a START_OF_RUN. Spill count and Event count not accurate. 

Written 1 event(s) to file.

Written 1 event(s) to file.

>Server:  MICE Production Server - Public read only interface 1.0.0.0

Welcome to MAUS:

	Process ID (PID): 12592

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/analyze_data_offline.py', '--output_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_offline_analysis.root', '--TOF_findTriggerPixelCut', '2.0']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 8 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 9 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 10 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 11 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 12 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 13 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 14 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 15 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 16 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 17 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

TRANSFORM/MERGE/OUTPUT:  Processed 18 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 19 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 20 events so far, 1 events in buffer.

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/src/common_py/ErrorHandler.py", line 162, in HandleCppException

    raise CppError(error_message)

ErrorHandler.CppError: In branch daq_data

In branch unknown

Failed to recognise all json properties V1731  at ObjectProcessor<ObjectType>::JsonToCpp

Written 19 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

TRANSFORM/MERGE/OUTPUT:  Processed 21 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 22 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 23 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 24 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 25 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 26 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Failed to find event 1 in file.

Failed to find event 1 in file.

Failed to find event 19 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Welcome to MAUS:

	Process ID (PID): 12709

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/utilities/root_to_json.py', '--input_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_offline_analysis.root', '--output_json_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_offline_analysis_IN.json', '--verbose_level', '1', '--header_and_footer_mode', 'dont_append']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 8 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 9 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 10 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 11 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 12 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 13 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 14 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 15 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 16 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 17 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 18 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 19 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 20 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 21 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 22 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 23 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Written 1 event(s) to file.

Written 1 event(s) to file.

Written 19 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

Welcome to MAUS:

	Process ID (PID): 12723

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/utilities/json_to_root.py', '--input_json_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_offline_analysis_IN.json', '--output_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_offline_analysis.root', '--verbose_level', '1', '--header_and_footer_mode', 'dont_append']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 8 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 9 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 10 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 11 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 12 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 13 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 14 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 15 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 16 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 17 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 18 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 19 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 20 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 21 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 22 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 23 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Failed to find event 1 in file.

Failed to find event 1 in file.

Failed to find event 19 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Welcome to MAUS:

	Process ID (PID): 12737

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/utilities/root_to_json.py', '--input_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_offline_analysis.root', '--output_json_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_offline_analysis_OUT.json', '--verbose_level', '1', '--header_and_footer_mode', 'dont_append']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 8 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 9 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 10 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 11 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 12 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 13 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 14 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 15 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 16 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 17 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 18 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 19 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 20 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 21 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 22 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 23 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

ok

Check that we can run simulate_mice, convert to root, convert back to ... Placing BeamLine.dat of type Box position: (0,0,-10283) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 209.641 m^3,  material: Galactic mass (excl daughters): 2.09641e-20 kg

Placing TrackerSolenoid0.dat of type Cylinder position: (0,0,-4783) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 4.2312 m^3,  material: Galactic mass (excl daughters): 4.2312e-22 kg

Placing AbsorberFocusCoil.dat68 of type Tube position: (0,0,-2750) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 1.37239 m^3,  material: Galactic mass (excl daughters): 1.37239e-22 kg

Placing RFCouplingCoilUp.dat of type Cylinder position: (0,0,-1375) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 2.56453 m^3,  material: Galactic mass (excl daughters): 2.56453e-22 kg

Placing AbsorberFocusCoil.dat81 of type Tube position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 1.37239 m^3,  material: Galactic mass (excl daughters): 1.37239e-22 kg

Placing RFCouplingCoilDown.dat of type Cylinder position: (0,0,1375) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 2.56453 m^3,  material: Galactic mass (excl daughters): 2.56453e-22 kg

Placing AbsorberFocusCoil.dat of type Tube position: (0,0,2750) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 1.37239 m^3,  material: Galactic mass (excl daughters): 1.37239e-22 kg

Placing SpecVirt.dat of type Cylinder position: (0,0,4783) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 2.82743e-08 m^3,  material: Galactic mass (excl daughters): 2.82743e-30 kg

Placing TrackerSolenoid1.dat of type Cylinder position: (0,0,4783) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 4.2312 m^3,  material: Galactic mass (excl daughters): 4.2312e-22 kg

Placing TOF2.dat of type Box position: (0,0,6524.5) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.5625 m^3,  material: AIR mass (excl daughters): 0.677694 kg

Setting the phase ....

Made 4 attempts to phase 8 cavities with 0 remaining

Solenoid Length: 198 Inner Radius: 258 Thickness: 52.8 Current Density: 1  scaleFactor: 104.612 position: (0,0,-3694) rotationVector: (0,0,1) angle: 0 name: Field1

Solenoid Length: 197 Inner Radius: 258 Thickness: 26.4 Current Density: 1  scaleFactor: 161.3 position: (0,0,-4134.5) rotationVector: (0,0,1) angle: 0 name: Field2

Solenoid Length: 110 Inner Radius: 258 Thickness: 61.6 Current Density: 1  scaleFactor: 136.8 position: (0,0,-4534.5) rotationVector: (0,0,1) angle: 0 name: Field3

Solenoid Length: 1294 Inner Radius: 258 Thickness: 22 Current Density: 1  scaleFactor: 146.9 position: (0,0,-5284) rotationVector: (0,0,1) angle: 0 name: Field4

Solenoid Length: 110 Inner Radius: 258 Thickness: 68.2 Current Density: 1  scaleFactor: 142.492 position: (0,0,-6034.5) rotationVector: (0,0,1) angle: 0 name: Field5

Solenoid Length: 210 Inner Radius: 263 Thickness: 84 Current Density: 1  scaleFactor: 113.95 position: (0,0,-2955) rotationVector: (0,0,1) angle: 0 name: Field6

Solenoid Length: 210 Inner Radius: 263 Thickness: 84 Current Density: 1  scaleFactor: -113.95 position: (0,0,-2545) rotationVector: (0,0,1) angle: 0 name: Field7

Solenoid Length: 250 Inner Radius: 725 Thickness: 116 Current Density: 1  scaleFactor: -96.21 position: (0,0,-1375) rotationVector: (0,0,1) angle: 0 name: Field8

Solenoid Length: 210 Inner Radius: 263 Thickness: 84 Current Density: 1  scaleFactor: -113.95 position: (0,0,-205) rotationVector: (0,0,1) angle: 0 name: Field9

Solenoid Length: 210 Inner Radius: 263 Thickness: 84 Current Density: 1  scaleFactor: 113.95 position: (0,0,205) rotationVector: (0,0,1) angle: 0 name: Field10

Solenoid Length: 250 Inner Radius: 725 Thickness: 116 Current Density: 1  scaleFactor: 96.21 position: (0,0,1375) rotationVector: (0,0,1) angle: 0 name: Field11

Solenoid Length: 210 Inner Radius: 263 Thickness: 84 Current Density: 1  scaleFactor: 113.95 position: (0,0,2545) rotationVector: (0,0,1) angle: 0 name: Field12

Solenoid Length: 210 Inner Radius: 263 Thickness: 84 Current Density: 1  scaleFactor: -113.95 position: (0,0,2955) rotationVector: (0,0,1) angle: 0 name: Field13

Solenoid Length: 198 Inner Radius: 258 Thickness: 52.8 Current Density: 1  scaleFactor: 104.612 position: (-1.33364e-13,0,3669.5) rotationVector: (0,-1,0) angle: 180 name: Field14

Solenoid Length: 197 Inner Radius: 258 Thickness: 26.4 Current Density: 1  scaleFactor: 161.3 position: (-7.94183e-14,0,4110) rotationVector: (0,-1,0) angle: 180 name: Field15

Solenoid Length: 110 Inner Radius: 258 Thickness: 61.6 Current Density: 1  scaleFactor: 136.8 position: (-3.04325e-14,0,4510) rotationVector: (0,-1,0) angle: 180 name: Field16

Solenoid Length: 1294 Inner Radius: 258 Thickness: 22 Current Density: 1  scaleFactor: 146.9 position: (6.13548e-14,0,5259.5) rotationVector: (0,-1,0) angle: 180 name: Field17

Solenoid Length: 110 Inner Radius: 258 Thickness: 68.2 Current Density: 1  scaleFactor: 142.492 position: (1.53265e-13,0,6010) rotationVector: (0,-1,0) angle: 180 name: Field18

Multipole Order: 4 Length: 2000 Magnitude: 1e-06 BendingRadius: 0 Height: 500 Width: 500 EndField: Tanh scaleFactor: 1.293 position: (0,0,-10959.5) rotationVector: (0,0,1) angle: 0 name: Field27

Multipole Order: 4 Length: 2000 Magnitude: 1e-06 BendingRadius: 0 Height: 500 Width: 500 EndField: Tanh scaleFactor: -1.293 position: (0,0,-9799.45) rotationVector: (0,0,1) angle: 0 name: Field28

Multipole Order: 4 Length: 2000 Magnitude: 1e-06 BendingRadius: 0 Height: 500 Width: 500 EndField: Tanh scaleFactor: 1.293 position: (0,0,-8639.45) rotationVector: (0,0,1) angle: 0 name: Field29

RFFieldMap Length: 430 PeakField: 0.009 Delay: 20.4494 Frequency: 0.20125 scaleFactor: 1 position: (0,0,-1140.75) rotationVector: (0,0,1) angle: 0 name: Field19

RFFieldMap Length: 430 PeakField: 0.009 Delay: 18.6388 Frequency: 0.20125 scaleFactor: 1 position: (0,0,-1609.25) rotationVector: (0,0,1) angle: 0 name: Field20

RFFieldMap Length: 430 PeakField: 0.009 Delay: 22.2516 Frequency: 0.20125 scaleFactor: 1 position: (0,0,-672.25) rotationVector: (0,0,1) angle: 0 name: Field21

RFFieldMap Length: 430 PeakField: 0.009 Delay: 16.8196 Frequency: 0.20125 scaleFactor: 1 position: (0,0,-2077.75) rotationVector: (0,0,1) angle: 0 name: Field22

RFFieldMap Length: 430 PeakField: 0.009 Delay: 30.9696 Frequency: 0.20125 scaleFactor: 1 position: (0,0,1609.25) rotationVector: (0,0,1) angle: 0 name: Field23

RFFieldMap Length: 430 PeakField: 0.009 Delay: 29.1894 Frequency: 0.20125 scaleFactor: 1 position: (0,0,1140.75) rotationVector: (0,0,1) angle: 0 name: Field24

RFFieldMap Length: 430 PeakField: 0.009 Delay: 32.7431 Frequency: 0.20125 scaleFactor: 1 position: (0,0,2077.75) rotationVector: (0,0,1) angle: 0 name: Field25

RFFieldMap Length: 430 PeakField: 0.009 Delay: 27.4019 Frequency: 0.20125 scaleFactor: 1 position: (0,0,672.25) rotationVector: (0,0,1) angle: 0 name: Field26

Written 1 event(s) to file.

Written 1 event(s) to file.

Written 3 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

Welcome to MAUS:

	Process ID (PID): 12753

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/simulate_mice.py', '--configuration_file', '/home/mice/MAUS/.maus_release/tests/integration/test_utilities/test_root_io/root_io_mc_config.py', '--output_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_simulate_mice.root']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 0 events in buffer.

  Missing an end_of_run spill...

  ...creating one to flush the mergers!

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Failed to find event 1 in file.

Failed to find event 1 in file.

Failed to find event 3 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Welcome to MAUS:

	Process ID (PID): 12856

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/utilities/root_to_json.py', '--input_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_simulate_mice.root', '--output_json_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_simulate_mice_IN.json', '--verbose_level', '1', '--header_and_footer_mode', 'dont_append']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Written 1 event(s) to file.

Written 1 event(s) to file.

Written 3 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

Welcome to MAUS:

	Process ID (PID): 12902

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/utilities/json_to_root.py', '--input_json_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_simulate_mice_IN.json', '--output_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_simulate_mice.root', '--verbose_level', '1', '--header_and_footer_mode', 'dont_append']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

Placing Box of type Box position: (0,0,0) mm, rotationVector: (0,0,1) angle: 0 degrees, volume (incl daughters): 0.001 m^3,  material: lH2 mass (excl daughters): 0.0708 kg

Setting the phase 

Made 0 attempts to phase 0 cavities with 0 remaining

Failed to find event 1 in file.

Failed to find event 1 in file.

Failed to find event 3 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Welcome to MAUS:

	Process ID (PID): 12917

	Program Arguments: ['/home/mice/MAUS/.maus_release/bin/utilities/root_to_json.py', '--input_root_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_simulate_mice.root', '--output_json_file_name', '/home/mice/MAUS/.maus_release/tmp/test_root_io_simulate_mice_OUT.json', '--verbose_level', '1', '--header_and_footer_mode', 'dont_append']

	Version: MAUS release version 0.7.3

Initialising Globals

Initiating Execution

OUTPUT: Setting up outputer

Writing JobHeader...

INPUT: Setting up input

PIPELINE: Get event, TRANSFORM, MERGE, OUTPUT, repeat

HINT: MAUS will process 1 event only at first...

TRANSFORM/MERGE/OUTPUT:  Processed 1 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 2 events so far, 1 events in buffer.

MERGE: Setting up merger

TRANSFORM: Setting up transformer

TRANSFORM/MERGE/OUTPUT:  Processed 3 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 4 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 5 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 6 events so far, 1 events in buffer.

TRANSFORM/MERGE/OUTPUT:  Processed 7 events so far, 0 events in buffer.

TRANSFORM: Shutting down transformer

MERGE: Shutting down merger

INPUT: Shutting down inputer

OUTPUT: Shutting down outputer

Clearing Globals

DONE

ok

======================================================================

FAIL: Check that analyze_data_online makes good histos for full run

----------------------------------------------------------------------

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_analyze_data_online/test_analyze_data_online.py", line 163, in test_root_histos

    self.assertEquals(test_pass, True)

AssertionError: False != True

-------------------- >> begin captured stdout << ---------------------

Linking /home/mice/MAUS/.maus_release/third_party/install/share/test_data/test_data.cat to /home/mice/MAUS/.maus_release/tmp/test_analyze_data_online/test_data.cat

/home/mice/MAUS/.maus_release/tmp/test_analyze_data_online//test_data.cat_histos//raw False /home/mice/MAUS/.maus_release/tmp/test_analyze_data_online//test_data.cat_histos/ True

Running analyze online

Point your browser at http://localhost:9000/maus/

. . . . . . . . . . . 

Printing output to  /home/mice/MAUS/.maus_release/tmp/test_analyze_data_online/test_data.cat_histos/end_of_run/4235/imageReducePyTOFPlot_compared.root

ht01 KolmogorovTest 0.0 7.0 0.0 Failure

spx0 KolmogorovTest 4.3 89.0 0.0 Failure

spx1 KolmogorovTest 4.3 89.0 0.749618774511 Pass

spx2 KolmogorovTest 4.3 89.0 1.0 Pass

spy0 KolmogorovTest 2.1 69.2 0.0 Failure

spy1 KolmogorovTest 2.1 69.2 0.892844327239 Pass

spy2 KolmogorovTest 2.1 69.2 1.0 Pass

hnsp_0 KolmogorovTest 14.0 498.0 0.808815753665 Pass

hnsp_1 KolmogorovTest 9.0 393.0 1.0 Pass

hnsp_2 KolmogorovTest 14.0 602.0 1.0 Pass

hpmthits000 KolmogorovTest 5.4 130.8 0.906299591992 Pass

hpmthits001 KolmogorovTest 5.4 130.8 0.906299591992 Pass

hpmthits010 KolmogorovTest 4.3 105.5 0.0974357615402 Warning

hpmthits011 KolmogorovTest 4.3 105.5 0.0974357615402 Warning

hpmthits100 KolmogorovTest 5.4 130.8 0.995638188383 Pass

hpmthits101 KolmogorovTest 5.4 130.8 0.995638188383 Pass

hpmthits110 KolmogorovTest 4.3 105.5 0.978051658365 Pass

hpmthits111 KolmogorovTest 4.3 105.5 0.978051658365 Pass

hpmthits200 KolmogorovTest 5.4 130.8 1.0 Pass

hpmthits201 KolmogorovTest 5.4 130.8 1.0 Pass

hpmthits210 KolmogorovTest 4.3 105.5 1.0 Pass

hpmthits211 KolmogorovTest 4.3 105.5 1.0 Pass

hslabhits00 KolmogorovTest 5.4 130.8 0.906299591992 Pass

hslabhits01 KolmogorovTest 4.3 105.5 0.0974357615402 Warning

hslabhits10 KolmogorovTest 5.4 130.8 0.995638188383 Pass

hslabhits11 KolmogorovTest 4.3 105.5 0.978051658365 Pass

hslabhits20 KolmogorovTest 5.4 130.8 1.0 Pass

hslabhits21 KolmogorovTest 4.3 105.5 1.0 Pass

hspxy_0 KolmogorovTest 0.0 8.0 1.0 Pass

hspxy_1 KolmogorovTest 1.0 24.0 1.0 Pass

Printing output to  /home/mice/MAUS/.maus_release/tmp/test_analyze_data_online/test_data.cat_histos/end_of_run/4235/imageReducePyCkovPlot_compared.root

htof KolmogorovTest 0.0 12.0 0.0 Failure

tof_A KolmogorovTest 0.0 2.0 0.0 Failure

tof_B KolmogorovTest 0.0 3.0 0.0 Failure

hPMT1 KolmogorovTest 0.0 547.0 0.0 Failure

hPMT2 KolmogorovTest 0.0 537.0 0.0 Failure

hPMT3 KolmogorovTest 0.0 542.0 0.0 Failure

hPMT4 KolmogorovTest 0.0 496.0 0.0 Failure

hPMT5 KolmogorovTest 0.0 500.0 0.0 Failure

hPMT6 KolmogorovTest 0.0 516.0 0.0 Failure

hPMT7 KolmogorovTest 0.0 533.0 0.0 Failure

hPMT8 KolmogorovTest 0.0 491.0 0.0 Failure

harr_time1 KolmogorovTest 0.0 4.0 0.0 Failure

harr_time2 KolmogorovTest 0.0 3.0 0.0 Failure

harr_time3 KolmogorovTest 0.0 3.0 0.0 Failure

harr_time4 KolmogorovTest 0.0 5.0 0.0 Failure

harr_time5 KolmogorovTest 0.0 5.0 0.0 Failure

harr_time6 KolmogorovTest 0.0 7.0 0.0 Failure

harr_time7 KolmogorovTest 0.0 6.0 0.0 Failure

harr_time8 KolmogorovTest 0.0 5.0 0.0 Failure

test file: /home/mice/MAUS/.maus_release/tmp/test_analyze_data_online/test_data.cat_histos/end_of_run/4235/imageReducePyCkovPlot.root passes: False

test file: /home/mice/MAUS/.maus_release/tmp/test_analyze_data_online/test_data.cat_histos/end_of_run/4235/imageReducePyTOFPlot.root passes: False

--------------------- >> end captured stdout << ----------------------

======================================================================

FAIL: Test that the GRID batch script works

----------------------------------------------------------------------

Traceback (most recent call last):

  File "/home/mice/MAUS/.maus_release/tests/integration/test_utilities/test_execute_against_data/test_execute_against_data.py", line 161, in test_main_success

    self.__check_recon_file()

  File "/home/mice/MAUS/.maus_release/tests/integration/test_utilities/test_execute_against_data/test_execute_against_data.py", line 124, in __check_recon_file

    self.assertEqual(data.GetSpill().GetDaqEventType(), "physics_event")

AssertionError: 'end_of_burst' != 'physics_event'

-------------------- >> begin captured stdout << ---------------------

Cleaning test directory

Found 03541.tar so not going to download

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/03541_sim.root

removing dir /home/mice/MAUS/.maus_release/tmp/test_batch/downloads

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/OnScalers.03541.txt

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/OnMon.03541.root

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/03541_recon.root

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/reco.log

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/sim.log

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/OnScalers.03541.root

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/download.log

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/batch.log

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/03541.000

removing file /home/mice/MAUS/.maus_release/tmp/test_batch/03541.md5

Unpacking for testing

--------------------- >> end captured stdout << ----------------------

----------------------------------------------------------------------

Ran 44 tests in 2211.357s

FAILED (failures=2)

 Kolmo Prob  h1 = tof01_ref, sum bin content =177  effective entries =177

 Kolmo Prob  h2 = tof01, sum bin content =218  effective entries =218

 Kolmo Prob     = 0.990583, Max Dist = 0.0443943