test_rebind.py 4.5 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147
  1. from __future__ import print_function
  2. import errno
  3. import logging
  4. import os
  5. import random
  6. import socket
  7. import subprocess
  8. import sys
  9. import time
  10. LOG_TIMEOUT = 60.0
  11. LOG_WAIT = 0.1
  12. def fail(msg):
  13. logging.error('FAIL')
  14. sys.exit(msg)
  15. def skip(msg):
  16. logging.warning('SKIP: {}'.format(msg))
  17. sys.exit(77)
  18. def try_connecting_to_socksport():
  19. socks_socket = socket.socket(socket.AF_INET, socket.SOCK_STREAM)
  20. if socks_socket.connect_ex(('127.0.0.1', socks_port)):
  21. tor_process.terminate()
  22. fail('Cannot connect to SOCKSPort')
  23. socks_socket.close()
  24. def wait_for_log(s):
  25. cutoff = time.time() + LOG_TIMEOUT
  26. while time.time() < cutoff:
  27. l = tor_process.stdout.readline()
  28. l = l.decode('utf8', 'backslashreplace')
  29. if s in l:
  30. logging.info('Tor logged: "{}"'.format(l.strip()))
  31. return
  32. # readline() returns a blank string when there is no output
  33. # avoid busy-waiting
  34. if len(l) == 0:
  35. logging.debug('Tor has not logged anything, waiting for "{}"'.format(s))
  36. time.sleep(LOG_WAIT)
  37. else:
  38. logging.info('Tor logged: "{}", waiting for "{}"'.format(l.strip(), s))
  39. fail('Could not find "{}" in logs after {} seconds'.format(s, LOG_TIMEOUT))
  40. def pick_random_port():
  41. port = 0
  42. random.seed()
  43. for i in range(8):
  44. port = random.randint(10000, 60000)
  45. s = socket.socket(socket.AF_INET, socket.SOCK_STREAM)
  46. if s.connect_ex(('127.0.0.1', port)) == 0:
  47. s.close()
  48. else:
  49. break
  50. if port == 0:
  51. fail('Could not find a random free port between 10000 and 60000')
  52. return port
  53. logging.basicConfig(level=logging.DEBUG,
  54. format='%(asctime)s.%(msecs)03d %(message)s',
  55. datefmt='%Y-%m-%d %H:%M:%S')
  56. if sys.hexversion < 0x02070000:
  57. fail("ERROR: unsupported Python version (should be >= 2.7)")
  58. if sys.hexversion > 0x03000000 and sys.hexversion < 0x03010000:
  59. fail("ERROR: unsupported Python3 version (should be >= 3.1)")
  60. if 'TOR_SKIP_TEST_REBIND' in os.environ:
  61. skip('$TOR_SKIP_TEST_REBIND is set')
  62. control_port = pick_random_port()
  63. socks_port = pick_random_port()
  64. assert control_port != 0
  65. assert socks_port != 0
  66. if len(sys.argv) < 3:
  67. fail('Usage: %s <path-to-tor> <data-dir>' % sys.argv[0])
  68. if not os.path.exists(sys.argv[1]):
  69. fail('ERROR: cannot find tor at %s' % sys.argv[1])
  70. if not os.path.exists(sys.argv[2]):
  71. fail('ERROR: cannot find datadir at %s' % sys.argv[2])
  72. tor_path = sys.argv[1]
  73. data_dir = sys.argv[2]
  74. empty_torrc_path = os.path.join(data_dir, 'empty_torrc')
  75. open(empty_torrc_path, 'w').close()
  76. empty_defaults_torrc_path = os.path.join(data_dir, 'empty_defaults_torrc')
  77. open(empty_defaults_torrc_path, 'w').close()
  78. tor_process = subprocess.Popen([tor_path,
  79. '-DataDirectory', data_dir,
  80. '-ControlPort', '127.0.0.1:{}'.format(control_port),
  81. '-SOCKSPort', '127.0.0.1:{}'.format(socks_port),
  82. '-Log', 'debug stdout',
  83. '-LogTimeGranularity', '1',
  84. '-FetchServerDescriptors', '0',
  85. '-f', empty_torrc_path,
  86. '--defaults-torrc', empty_defaults_torrc_path,
  87. ],
  88. stdout=subprocess.PIPE,
  89. stderr=subprocess.PIPE)
  90. if tor_process == None:
  91. fail('ERROR: running tor failed')
  92. wait_for_log('Opened Control listener on')
  93. try_connecting_to_socksport()
  94. control_socket = socket.socket(socket.AF_INET, socket.SOCK_STREAM)
  95. if control_socket.connect_ex(('127.0.0.1', control_port)):
  96. tor_process.terminate()
  97. fail('Cannot connect to ControlPort')
  98. control_socket.sendall('AUTHENTICATE \r\n'.encode('ascii'))
  99. control_socket.sendall('SETCONF SOCKSPort=0.0.0.0:{}\r\n'.format(socks_port).encode('ascii'))
  100. wait_for_log('Opened Socks listener')
  101. try_connecting_to_socksport()
  102. control_socket.sendall('SETCONF SOCKSPort=127.0.0.1:{}\r\n'.format(socks_port).encode('ascii'))
  103. wait_for_log('Opened Socks listener')
  104. try_connecting_to_socksport()
  105. control_socket.sendall('SIGNAL HALT\r\n'.encode('ascii'))
  106. wait_for_log('exiting cleanly')
  107. logging.info('OK')
  108. try:
  109. tor_process.terminate()
  110. except OSError as e:
  111. if e.errno == errno.ESRCH: # errno 3: No such process
  112. # assume tor has already exited due to SIGNAL HALT
  113. logging.warn("Tor has already exited")
  114. else:
  115. raise