test_rebind.py 4.5 KB

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