analysis/test_embedding_example.py

=== stdout of analysis/tests/test_embedding_example.py ===
[INFO] Steering file: /data/b2soft/buildbot/development/releases/current/analysis/tests/test_embedding_example.py
[INFO] Steering file: /data/b2soft/buildbot/development/releases/current/analysis/examples/embedding/embedding.py
[INFO] Steering file: udst_purge_list.py
[INFO] Modules and parameter settings in the path:
  1. input1
      inputFileName=/belle2/examples-data/embedding_skim_BplusToKplusJpsiMuMu_bucket17.udst.root
  2. VariablesToEventExtraInfo_B+:BplusToKplusJpsiMuMu
      particleList=B+:BplusToKplusJpsiMuMu
      variables={'charge': 'bcharge'}
  3. chargeFilter
      variable=bcharge

      (? !=1[] ):
  4. TreeFitter_B+:BplusToKplusJpsiMuMu
      confidenceLevel=0.001
      particleList=B+:BplusToKplusJpsiMuMu
  5. VariablesToEventExtraInfo_B+:BplusToKplusJpsiMuMu
      particleList=B+:BplusToKplusJpsiMuMu
      variables={'chiProb': 'chiProb'}
  6. fitFilter
      variable=fitProb

      (? <0[] ):
  7. eventFilter
      variable=nB

      (? !=1[] ):
  8. VariablesToEventExtraInfo_B+:BplusToKplusJpsiMuMu
      particleList=B+:BplusToKplusJpsiMuMu
      variables={'IPX': 'IPX', 'IPY': 'IPY', 'IPZ': 'IPZ', 'px': 'PX', 'py': 'PY', 'pz': 'PZ', 'x': 'X', 'y': 'Y', 'z': 'Z'}
  9. filter1
      keepNotInList=True
      listName=B+:BplusToKplusJpsiMuMu
  10. RootOutput
      additionalDataDescription={'dataLevel': 'mdst'}
      branchNames=['ECLClusters', 'ECLClustersToTracksNamedBremsstrahlung', 'EventLevelClusteringInfo', 'EventLevelTrackingInfo', 'EventLevelTriggerTimeInfo', 'KLMClusters', 'KlIds', 'PIDLikelihoods', 'SoftwareTriggerResult', 'TrackFitResults', 'Tracks', 'TRGSummary', 'V0s', 'MCParticles', 'EventExtraInfo']
      branchNamesPersistent=['FileMetaData', 'BackgroundInfo']
      outputFileName=data.root
  11. Progress
[INFO] Starting event processing, random seed is set to '12bb87cbaf4b01c874e371d654ee525769f22f195f521e5f1f486b42d3b1fba5'
[INFO] Added file /belle2/examples-data/embedding_skim_BplusToKplusJpsiMuMu_bucket17.udst.root
[WARNING] The branch EventLevelTriggerTimeInfo given in branchNames does not exist.  { module: RootOutput }
[WARNING] The branch MCParticles given in branchNames does not exist.  { module: RootOutput }
[WARNING] The branch BackgroundInfo given in branchNamesPersistent does not exist.  { module: RootOutput }
[INFO] Conditions Database: found working server
	url = http://belle2db.sdcc.bnl.gov/b2s/rest/
[INFO] Conditions data: configured globaltags (highest priority first) are data_reprocessing_prompt, AIRFLOW_online_snapshot_20210326-130954, Legacy_CollisionAxisCMS
[INFO] Begin of new run.
[INFO] Processed:   1 runs,      1/   205 events.
[INFO] Begin of new run.
[INFO] Processed:   2 runs,      2/   205 events.
[ERROR] Conditions Database: Problem parsing payload information.
	globaltag = AIRFLOW_online_snapshot_20210326-130954
	server url = http://belle2db.sdcc.bnl.gov/b2s/rest/
	error = Operation too slow. Less than 10240 bytes/sec transferred the last 60 seconds
[WARNING] Conditions data: Problem with payload metadata provider, trying to fall back to next provider...
	provider = http://belle2db.sdcc.bnl.gov/b2s/rest/
[INFO] Begin of new run.
[INFO] Processed:   3 runs,      3/   205 events.
[INFO] Begin of new run.
[INFO] Processed:   4 runs,      4/   205 events.
[INFO] Begin of new run.
 ... message repeated 1 times
[INFO] Processed:   6 runs,      5/   205 events.
[INFO] Begin of new run.
[INFO] Processed:   7 runs,      6/   205 events.
[INFO] Begin of new run.
[INFO] Processed:   8 runs,      7/   205 events.
[INFO] Begin of new run.
[INFO] Processed:   9 runs,      8/   205 events.
[INFO] Processed:   9 runs,      9/   205 events.
[INFO] Processed:   9 runs,     10/   205 events.
[INFO] Begin of new run.
 ... message repeated 11 times
[INFO] Processed:  21 runs,     20/   205 events.
[INFO] Begin of new run.
 ... message repeated 10 times
[INFO] Processed:  32 runs,     30/   205 events.
[INFO] Begin of new run.
 ... message repeated 6 times
[INFO] Processed:  39 runs,     40/   205 events.
[INFO] Begin of new run.
 ... message repeated 13 times
[INFO] Processed:  53 runs,     50/   205 events.
[INFO] Begin of new run.
 ... message repeated 12 times
[INFO] Processed:  66 runs,     60/   205 events.
[INFO] Begin of new run.
 ... message repeated 12 times
[INFO] Processed:  79 runs,     70/   205 events.
[INFO] Begin of new run.
 ... message repeated 9 times
[INFO] Processed:  89 runs,     80/   205 events.
[INFO] Begin of new run.
 ... message repeated 5 times
[INFO] Processed:  95 runs,     90/   205 events.
[INFO] Begin of new run.
 ... message repeated 6 times
[INFO] Processed: 102 runs,    100/   205 events.
[INFO] ================================================================================
[INFO]             ,.,                                                                 
[INFO]            ;%&M%;_   ,..,                                                       
[INFO]              "_ "__" % M % M %;          , ..., ,                               
[INFO]       , ..., __." --"    , .,     _ - " % &W % WM %;                            
[INFO]      ; % M&$M % "___ "_._   %M%"_."" _ """"""                                   
[INFO]        """""    "" , \_.   "_. ."                                               
[INFO]               , ., _"__ \__./ ."                                                
[INFO]           ___       __ |  y     , ..,     Thank you for using TreeFitter.       
[INFO]          /)'\    ''''| u  \ %W%W%%;                                             
[INFO]      ___)/   "---\_ \   |____"            Please cite both:                     
[INFO]    ;&&%%;           (|__.|)./  ,..,           10.1016/j.nima.2020.164269        
[INFO]              ,.., ___\    |/     &&"          10.1016/j.nima.2005.06.078        
[INFO]            &&%%&    (| Uo /        '"     Email:                                
[INFO]             ''''     \ 7 \                   francesco.tenchini@desy.de         
[INFO]   ._______________.-'____""-.____.           jo-frederik.krohn@desy.de          
[INFO]    \                           /                                                
[INFO]     \       TREEFITTER        /                                                 
[INFO]      \_______________________/                                                  
[INFO]       (_)                 (_)                                                   
[INFO]                                                                                 
[INFO] ============= TREEFIT STATISTICS ===============================================
[INFO] Target particle list: B+:BplusToKplusJpsiMuMu
[INFO] Candidates before fit: 105
[INFO] Candidates after fit:  100
[INFO] A total of 5 candidates were removed during the fit.
[INFO] 95.2381% of candidates survived the fit.
[INFO] 4.7619% of candidates did not.
[INFO] You chose to drop all candidates with pValue < 0.001.
[INFO] ================================================================================
[INFO] ===Error Summary================================================================
[ERROR] Conditions Database: Problem parsing payload information.
	globaltag = AIRFLOW_online_snapshot_20210326-130954
	server url = http://belle2db.sdcc.bnl.gov/b2s/rest/
	error = Operation too slow. Less than 10240 bytes/sec transferred the last 60 seconds
[WARNING] Conditions data: Problem with payload metadata provider, trying to fall back to next provider...
	provider = http://belle2db.sdcc.bnl.gov/b2s/rest/
[WARNING] The branch BackgroundInfo given in branchNamesPersistent does not exist.  { module: RootOutput }
[WARNING] The branch MCParticles given in branchNames does not exist.  { module: RootOutput }
[WARNING] The branch EventLevelTriggerTimeInfo given in branchNames does not exist.  { module: RootOutput }
[INFO] ================================================================================
[ERROR] in total, 1 errors occurred during processing
[WARNING] in total, 4 warnings occurred during processing
=============================================================================================================
Name                                              |      Calls | Memory(MB) |    Time(s) |     Time(ms)/Call
=============================================================================================================
input1                                            |        206 |          0 |       0.21 |    1.04 +-   0.71
VariablesToEventExtraInfo_B+:BplusToKplusJpsiMuMu |        205 |          0 |       0.01 |    0.03 +-   0.01
chargeFilter                                      |        205 |          0 |       0.00 |    0.02 +-   0.01
TreeFitter_B+:BplusToKplusJpsiMuMu                |        105 |        190 |       1.81 |   17.23 +- 172.82
VariablesToEventExtraInfo_B+:BplusToKplusJpsiMuMu |        105 |          0 |       0.00 |    0.02 +-   0.01
fitFilter                                         |        105 |          0 |       0.00 |    0.01 +-   0.00
eventFilter                                       |        100 |          0 |       0.00 |    0.02 +-   0.01
VariablesToEventExtraInfo_B+:BplusToKplusJpsiMuMu |        100 |          0 |       0.01 |    0.09 +-   0.67
filter1                                           |        100 |          0 |       0.02 |    0.24 +-   0.06
RootOutput                                        |        100 |          0 |       0.05 |    0.49 +-   0.30
Progress                                          |        100 |          0 |       0.00 |    0.02 +-   0.02
=============================================================================================================
Total                                             |        206 |        191 |       2.17 |   10.56 +- 124.20
=============================================================================================================

[INFO] Steering file: udst_purge_list.py
[INFO] Modules and parameter settings in the path:
  1. input1
      inputFileName=/belle2/examples-data/embedding_skim_sig_71_Bplus2Kplus.udst.root
  2. VariablesToEventExtraInfo_B+:BplusToKplusNuNu
      particleList=B+:BplusToKplusNuNu
      variables={'charge': 'bcharge'}
  3. chargeFilter
      variable=bcharge

      (? !=1[] ):
  4. eventFilter
      variable=nB

      (? !=1[] ):
  5. VariablesToEventExtraInfo_B+:BplusToKplusNuNu
      particleList=B+:BplusToKplusNuNu
      variables={'IPX': 'IPX', 'IPY': 'IPY', 'IPZ': 'IPZ', 'mcDecayVertexX': 'X', 'mcDecayVertexY': 'Y', 'mcDecayVertexZ': 'Z', 'mcPX': 'PX', 'mcPY': 'PY', 'mcPZ': 'PZ'}
  6. filter2
      listName=B+:BplusToKplusNuNu
  7. RootOutput
      additionalDataDescription={'dataLevel': 'mdst'}
      branchNames=['ECLClusters', 'ECLClustersToTracksNamedBremsstrahlung', 'EventLevelClusteringInfo', 'EventLevelTrackingInfo', 'EventLevelTriggerTimeInfo', 'KLMClusters', 'KlIds', 'PIDLikelihoods', 'SoftwareTriggerResult', 'TrackFitResults', 'Tracks', 'TRGSummary', 'V0s', 'MCParticles', 'EventExtraInfo']
      branchNamesPersistent=['FileMetaData', 'BackgroundInfo']
      outputFileName=sigmc.root
  8. Progress
[INFO] Starting event processing, random seed is set to 'd7644a03a36d86ab8837baded66846f85079c06d8d500d2d3d7d6878c559f5'
[INFO] Added file /belle2/examples-data/embedding_skim_sig_71_Bplus2Kplus.udst.root
[WARNING] The branch EventLevelTriggerTimeInfo given in branchNames does not exist.  { module: RootOutput }
[INFO] Begin of new run.
[INFO] Conditions Database: found working server
	url = http://belle2db.sdcc.bnl.gov/b2s/rest/
[INFO] Conditions data: configured globaltags (highest priority first) are mc_production_MC14a, release-05-01-09, Legacy_CollisionAxisCMS
[INFO] Processed:   1 runs,      1/ 23107 events.
[INFO] Processed:   1 runs,      2/ 23107 events.
[INFO] Processed:   1 runs,      3/ 23107 events.
[INFO] Processed:   1 runs,      4/ 23107 events.
[INFO] Processed:   1 runs,      5/ 23107 events.
[INFO] Processed:   1 runs,      6/ 23107 events.
[INFO] Processed:   1 runs,      7/ 23107 events.
[INFO] Processed:   1 runs,      8/ 23107 events.
[INFO] Processed:   1 runs,      9/ 23107 events.
[INFO] Processed:   1 runs,     10/ 23107 events.
[INFO] Processed:   1 runs,     20/ 23107 events.
[INFO] Processed:   1 runs,     30/ 23107 events.
[INFO] Processed:   1 runs,     40/ 23107 events.
[INFO] Processed:   1 runs,     50/ 23107 events.
[INFO] Processed:   1 runs,     60/ 23107 events.
[INFO] Processed:   1 runs,     70/ 23107 events.
[INFO] Processed:   1 runs,     80/ 23107 events.
[INFO] Processed:   1 runs,     90/ 23107 events.
[INFO] Processed:   1 runs,    100/ 23107 events.
[INFO] Processed:   1 runs,    200/ 23107 events.
[INFO] Processed:   1 runs,    300/ 23107 events.
[INFO] Processed:   1 runs,    400/ 23107 events.
[INFO] Processed:   1 runs,    500/ 23107 events.
[INFO] Processed:   1 runs,    600/ 23107 events.
[INFO] Processed:   1 runs,    700/ 23107 events.
[INFO] Processed:   1 runs,    800/ 23107 events.
[INFO] Processed:   1 runs,    900/ 23107 events.
[INFO] Processed:   1 runs,   1000/ 23107 events.
[INFO] Processed:   1 runs,   2000/ 23107 events.
[INFO] Processed:   1 runs,   3000/ 23107 events.
[INFO] Processed:   1 runs,   4000/ 23107 events.
[INFO] Processed:   1 runs,   5000/ 23107 events.
[INFO] Processed:   1 runs,   6000/ 23107 events.
[INFO] Processed:   1 runs,   7000/ 23107 events.
[INFO] Processed:   1 runs,   8000/ 23107 events.
[INFO] Processed:   1 runs,   9000/ 23107 events.
[INFO] Processed:   1 runs,  10000/ 23107 events.
[INFO] Processed:   1 runs,  11000/ 23107 events.
[INFO] ===Error Summary================================================================
[WARNING] The branch EventLevelTriggerTimeInfo given in branchNames does not exist.  { module: RootOutput }
[INFO] ================================================================================
[WARNING] in total, 1 warnings occurred during processing
=========================================================================================================
Name                                          |      Calls | Memory(MB) |    Time(s) |     Time(ms)/Call
=========================================================================================================
input1                                        |      23108 |         21 |       6.62 |    0.29 +-   2.32
VariablesToEventExtraInfo_B+:BplusToKplusNuNu |      23107 |          0 |       0.36 |    0.02 +-   0.01
chargeFilter                                  |      23107 |          0 |       0.31 |    0.01 +-   0.00
eventFilter                                   |      11554 |          0 |       0.16 |    0.01 +-   0.01
VariablesToEventExtraInfo_B+:BplusToKplusNuNu |      11554 |          3 |      23.10 |    2.00 +- 212.15
filter2                                       |      11554 |          0 |       1.34 |    0.12 +-   0.03
RootOutput                                    |      11554 |         45 |       4.56 |    0.39 +-   7.66
Progress                                      |      11554 |          0 |       0.15 |    0.01 +-   0.01
=========================================================================================================
Total                                         |      23108 |         69 |      40.50 |    1.75 +- 150.15
=========================================================================================================

[INFO] Steering file: embedding_merge.py
[INFO] Starting event processing, random seed is set to 'f2f2b83a103a5fbea5507e15ea16e633a8bc293c6768b6bd2a3cf8b26aafcbdc'
[INFO] Added file data.root
[INFO] Added file sigmc.root
[WARNING] The branch EventLevelTriggerTimeInfo given in branchNames does not exist.  { module: RootOutput }
[WARNING] The branch BackgroundInfo given in branchNamesPersistent does not exist.  { module: RootOutput }
[INFO] Module 'SteerRootInputModule' is controlling the number of processed events.
[INFO] Begin of new run.
[INFO] Conditions Database: found working server
	url = http://belle2db.sdcc.bnl.gov/b2s/rest/
[ERROR] Conditions Database: Cannot download information on global tag. Usually this means it doesn't exist and you misspelled the name
	server url = http://belle2db.sdcc.bnl.gov/b2s/rest/
	globaltag = Legacy_CollisionAxisCMS  { module: PostMergeUpdater }
[FATAL] Conditions data: Problems with globaltag configuration, cannot continue  { module: PostMergeUpdater function: void Belle2::Database::nextMetadataProvider() }
[INFO] ===Error Summary================================================================
[FATAL] Conditions data: Problems with globaltag configuration, cannot continue  { module: PostMergeUpdater }
[ERROR] Conditions Database: Cannot download information on global tag. Usually this means it doesn't exist and you misspelled the name
	server url = http://belle2db.sdcc.bnl.gov/b2s/rest/
	globaltag = Legacy_CollisionAxisCMS  { module: PostMergeUpdater }
[WARNING] The branch BackgroundInfo given in branchNamesPersistent does not exist.  { module: RootOutput }
[WARNING] The branch EventLevelTriggerTimeInfo given in branchNames does not exist.  { module: RootOutput }
[INFO] ================================================================================
[ERROR] in total, 1 errors occurred during processing
[WARNING] in total, 2 warnings occurred during processing
Traceback (most recent call last):
  File "/data/b2soft/buildbot/development/releases/current/analysis/examples/embedding/embedding.py", line 38, in 
    subprocess.check_call(cmd.split())
  File "/cvmfs/belle.cern.ch/el7/externals/v02-00-01/Linux_x86_64/common/lib/python3.8/subprocess.py", line 364, in check_call
    raise CalledProcessError(retcode, cmd)
subprocess.CalledProcessError: Command '['basf2', 'embedding_merge.py', '--', '--filePrimary', 'data.root', '--fileSecondary', 'sigmc.root', '--fileOut', 'embedded_data.root']' returned non-zero exit status 1.
=== stderr of analysis/tests/test_embedding_example.py ===
F
======================================================================
FAIL: testEmbedding (__main__.TestEmbedding)
Test the embedding example.
----------------------------------------------------------------------
Traceback (most recent call last):
  File "/data/b2soft/buildbot/development/releases/current/analysis/tests/test_embedding_example.py", line 37, in testEmbedding
    self.assertEqual(result.returncode, 0)
AssertionError: 1 != 0

----------------------------------------------------------------------
Ran 1 test in 309.314s

FAILED (failures=1)
=== end analysis/tests/test_embedding_example.py ===