Check that analyze_data_online makes good histos for full run ... ok

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.

Written 26 event(s) to file.

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): 335

	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.

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, 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 26 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Welcome to MAUS:

	Process ID (PID): 394

	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, 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, 1 events in buffer.

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

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

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

TRANSFORM/MERGE/OUTPUT:  Processed 30 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 19:33:50,733: WARNING/MainProcess] discard: Erased 0 message from the queue.

[2014-02-04 19:33:50,735: 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 19:33:50,758: INFO/MainProcess] MAUS version: MAUS release version 0.7.3

[2014-02-04 19:33:50,772: INFO/PoolWorker-1] child process calling self.run()

[2014-02-04 19:33:50,775: INFO/PoolWorker-1] Setting MAUS ErrorHandler to raise exceptions

[2014-02-04 19:33:50,770: INFO/PoolWorker-2] child process calling self.run()

[2014-02-04 19:33:50,771: WARNING/MainProcess] celery@miceonrec02a.micenet.rl.ac.uk has started.

[2014-02-04 19:33:50,772: 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 19:33:53,984: 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 19:33:54,053: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:33:54,054: INFO/PoolWorker-2] Birthing transform MapPyPrint

[2014-02-04 19:33:54,054: INFO/PoolWorker-2] 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 19:33:54,122: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:33:54,122: INFO/PoolWorker-1] Birthing transform MapPyPrint

[2014-02-04 19:33:54,123: INFO/PoolWorker-1] Finished birthing transforms MapPyPrint

[2014-02-04 19:33:54,119: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 19:33:58,158: INFO/MainProcess] Birthing transform MapPyPrint

[2014-02-04 19:33:58,165: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:33:58,165: INFO/PoolWorker-1] Birthing transform MapPyPrint

[2014-02-04 19:33:58,165: INFO/PoolWorker-1] Finished birthing transforms MapPyPrint

[2014-02-04 19:33:58,162: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:33:58,162: INFO/PoolWorker-2] Birthing transform MapPyPrint

[2014-02-04 19:33:58,163: INFO/PoolWorker-2] Finished birthing transforms MapPyPrint

[2014-02-04 19:33:58,163: 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 19:34:05,269: INFO/MainProcess] Birthing transform MapPyPrint

[2014-02-04 19:34:05,269: 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 19:34:10,352: INFO/MainProcess] Birthing transform MapPyUnknown

[2014-02-04 19:34:10,353: 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 19:34:15,446: INFO/MainProcess] Birthing transform MapPyPrint

[2014-02-04 19:34:15,446: 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 19:34:20,532: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 19:34:20,538: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:34:20,538: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 19:34:20,536: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:34:20,536: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 19:34:20,538: 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 19:34:25,627: INFO/MainProcess] Deathing transform

[2014-02-04 19:34:25,628: INFO/MainProcess] Status: {'status': 'ok', 'run_footers': []}

[2014-02-04 19:34:27,645: INFO/MainProcess] Deathing transform

[2014-02-04 19:34:27,647: 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 19:34:32,731: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 19:34:32,732: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:34:32,733: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 19:34:32,733: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 19:34:32,739: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:34:32,739: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 19:34:32,740: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 19:34:32,735: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 19:34:34,752: INFO/MainProcess] Birthing transform MapPyDoNothing

[2014-02-04 19:34:34,754: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:34:34,754: INFO/PoolWorker-2] Birthing transform MapPyDoNothing

[2014-02-04 19:34:34,759: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:34:34,760: INFO/PoolWorker-1] Birthing transform MapPyDoNothing

[2014-02-04 19:34:34,756: 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 19:34:36,772: INFO/MainProcess] Birthing transform MapPyDoNothing

[2014-02-04 19:34:36,772: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:34:36,773: INFO/PoolWorker-2] Birthing transform MapPyDoNothing

[2014-02-04 19:34:36,774: INFO/PoolWorker-2] Finished birthing transforms MapPyDoNothing

[2014-02-04 19:34:36,779: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:34:36,779: INFO/PoolWorker-1] Birthing transform MapPyDoNothing

[2014-02-04 19:34:36,780: INFO/PoolWorker-1] Finished birthing transforms MapPyDoNothing

[2014-02-04 19:34:36,776: 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 19:34:43,884: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 19:34:43,885: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:34:43,886: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 19:34:43,886: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 19:34:43,891: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:34:43,892: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 19:34:43,892: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 19:34:43,888: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 19:34:45,905: INFO/MainProcess] Deathing transform

[2014-02-04 19:34:45,905: INFO/PoolWorker-2] Deathing transform 1

[2014-02-04 19:34:45,911: INFO/PoolWorker-1] Deathing transform 1

[2014-02-04 19:34:45,907: INFO/MainProcess] Status: {'status': 'error', 'run_footers': [], 'error': [{'message': 'Death exception', 'error': "<type 'exceptions.ValueError'>"}]}

[2014-02-04 19:34:47,923: INFO/MainProcess] Deathing transform

[2014-02-04 19:34:47,924: 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 19:34:53,008: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 19:34:53,008: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:34:53,009: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 19:34:53,009: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 19:34:53,015: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:34:53,015: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 19:34:53,015: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 19:34:53,011: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 19:34:55,026: INFO/MainProcess] Got task from broker: mauscelery.maustasks.MausGenericTransformTask[92459f83-382a-4549-bd1e-6431d7919f7a]

[2014-02-04 19:34:55,055: INFO/PoolWorker-2] None[92459f83-382a-4549-bd1e-6431d7919f7a]: Task invoked by 1

[2014-02-04 19:34:55,069: INFO/MainProcess] Task mauscelery.maustasks.MausGenericTransformTask[92459f83-382a-4549-bd1e-6431d7919f7a] succeeded in 0.0141589641571s: '{"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 19:34:58,147: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 19:34:58,153: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:34:58,154: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 19:34:58,154: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 19:34:58,150: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:34:58,151: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 19:34:58,151: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 19:34:58,152: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 19:35:00,166: INFO/MainProcess] Deathing transform

[2014-02-04 19:35:00,172: INFO/PoolWorker-1] Deathing transform 1

[2014-02-04 19:35:00,169: INFO/PoolWorker-2] Deathing transform 1

[2014-02-04 19:35:00,169: INFO/MainProcess] Status: {'status': 'ok', 'run_footers': ['{"maus_event_type":"RunFooter","run_number":1}', '{"maus_event_type":"RunFooter","run_number":1}']}

[2014-02-04 19:35:02,181: INFO/MainProcess] Got task from broker: mauscelery.maustasks.MausGenericTransformTask[f0edddea-40c7-4d43-a2dc-4c9a70d0f0b0]

[2014-02-04 19:35:02,229: INFO/PoolWorker-1] None[f0edddea-40c7-4d43-a2dc-4c9a70d0f0b0]: Task invoked by 1

[2014-02-04 19:35:02,241: ERROR/MainProcess] Task mauscelery.maustasks.MausGenericTransformTask[f0edddea-40c7-4d43-a2dc-4c9a70d0f0b0] 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 19:35:05,313: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 19:35:05,314: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:35:05,315: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 19:35:05,316: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 19:35:05,321: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:35:05,322: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 19:35:05,323: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 19:35:05,319: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 19:35:07,331: INFO/MainProcess] Got task from broker: mauscelery.maustasks.MausGenericTransformTask[d14f37f5-46aa-4c82-9771-65f7fdf643e6]

[2014-02-04 19:35:07,340: INFO/PoolWorker-2] None[d14f37f5-46aa-4c82-9771-65f7fdf643e6]: Task invoked by 1

[2014-02-04 19:35:07,340: WARNING/PoolWorker-2] Sleeping for

[2014-02-04 19:35:07,340: WARNING/PoolWorker-2] 9.0

[2014-02-04 19:35:07,341: WARNING/PoolWorker-2] seconds

[2014-02-04 19:35:16,349: INFO/MainProcess] Task mauscelery.maustasks.MausGenericTransformTask[d14f37f5-46aa-4c82-9771-65f7fdf643e6] succeeded in 9.00981712341s: '{"processed": [""]}'

[2014-02-04 19:35:16,355: INFO/MainProcess] Birthing transform MapPyTestMap

[2014-02-04 19:35:16,362: INFO/PoolWorker-1] Start of run action

[2014-02-04 19:35:16,363: INFO/PoolWorker-1] Birthing transform MapPyTestMap

[2014-02-04 19:35:16,364: INFO/PoolWorker-1] Finished birthing transforms MapPyTestMap

[2014-02-04 19:35:16,360: INFO/PoolWorker-2] Start of run action

[2014-02-04 19:35:16,361: INFO/PoolWorker-2] Birthing transform MapPyTestMap

[2014-02-04 19:35:16,362: INFO/PoolWorker-2] Finished birthing transforms MapPyTestMap

[2014-02-04 19:35:16,362: INFO/MainProcess] Status: {'status': 'ok', 'run_headers': ['{"maus_event_type":"RunHeader","run_number":1}', '{"maus_event_type":"RunHeader","run_number":1}']}

[2014-02-04 19:35:18,376: INFO/MainProcess] Got task from broker: mauscelery.maustasks.MausGenericTransformTask[102694bb-3bb6-4a4c-9b3b-cbee03f39485]

[2014-02-04 19:35:18,386: INFO/PoolWorker-1] None[102694bb-3bb6-4a4c-9b3b-cbee03f39485]: Task invoked by 1

[2014-02-04 19:35:18,387: WARNING/PoolWorker-1] Sleeping for

[2014-02-04 19:35:18,387: WARNING/PoolWorker-1] 15.0

[2014-02-04 19:35:18,387: WARNING/PoolWorker-1] seconds

[2014-02-04 19:35:29,057: ERROR/MainProcess] Task mauscelery.maustasks.MausGenericTransformTask[102694bb-3bb6-4a4c-9b3b-cbee03f39485] 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 19:35:29,057: ERROR/MainProcess] Hard time limit (10s) exceeded for mauscelery.maustasks.MausGenericTransformTask[102694bb-3bb6-4a4c-9b3b-cbee03f39485]

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

[2014-02-04 19:35:29,059: WARNING/MainProcess] Couldn't send result for '102694bb-3bb6-4a4c-9b3b-cbee03f39485': error(32, 'Broken pipe'). Retry in 0s.

[2014-02-04 19:35:29,067: 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 19:35:29,076: INFO/PoolWorker-2] process shutting down

[2014-02-04 19:35:29,077: INFO/PoolWorker-2] 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

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 ... ok

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.

Written 26 event(s) to file.

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): 2914

	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.

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, 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 26 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Welcome to MAUS:

	Process ID (PID): 2970

	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, 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, 1 events in buffer.

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

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

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

TRANSFORM/MERGE/OUTPUT:  Processed 30 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 26 event(s) to file.

Written 1 event(s) to file.

Written 1 event(s) to file.

Welcome to MAUS:

	Process ID (PID): 2995

	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, 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, 1 events in buffer.

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

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

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

TRANSFORM/MERGE/OUTPUT:  Processed 30 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 26 in file.

Failed to find event 1 in file.

Failed to find event 1 in file.

Welcome to MAUS:

	Process ID (PID): 3048

	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, 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, 1 events in buffer.

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

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

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

TRANSFORM/MERGE/OUTPUT:  Processed 30 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): 3156

	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): 3259

	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): 3305

	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): 3319

	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

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

Ran 44 tests in 3887.986s

OK

 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