builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0029 starttime: 1454761898.68 results: success (0) buildid: 20160206043136 builduid: 3d198835ad75473f9a6d1fe3f25c3476 revision: f5bd25c789b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.684072) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.684595) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.684887) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005824 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.742184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.742506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.771984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.772379) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005439 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.833358) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.833725) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.834128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:38.834409) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-06 04:31:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.82M=0.001s 2016-02-06 04:31:39 (9.82 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.531773 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:39.392973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:39.393306) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026191 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:39.462855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:39.463352) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5bd25c789b6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f5bd25c789b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-06 04:31:39,556 Setting DEBUG logging. 2016-02-06 04:31:39,556 attempt 1/10 2016-02-06 04:31:39,556 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5bd25c789b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:31:40,408 unpacking tar archive at: fx-team-f5bd25c789b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.088071 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:40.583036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:40.583372) ========= echo f5bd25c789b6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f5bd25c789b6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False f5bd25c789b6 program finished with exit code 0 elapsedTime=0.005784 script_repo_revision: 'f5bd25c789b6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:40.635111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:40.635428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:40.648466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-06 04:31:40.648869) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:31:40 INFO - MultiFileLogger online at 20160206 04:31:40 in /builds/slave/test 04:31:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:31:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:40 INFO - {'append_to_log': False, 04:31:40 INFO - 'base_work_dir': '/builds/slave/test', 04:31:40 INFO - 'blob_upload_branch': 'Fx-Team', 04:31:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:40 INFO - 'branch': 'Fx-Team', 04:31:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:40 INFO - 'config_files': ('talos/mac_config.py',), 04:31:40 INFO - 'default_actions': ('clobber', 04:31:40 INFO - 'read-buildbot-config', 04:31:40 INFO - 'download-and-extract', 04:31:40 INFO - 'populate-webroot', 04:31:40 INFO - 'create-virtualenv', 04:31:40 INFO - 'install', 04:31:40 INFO - 'run-tests'), 04:31:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:40 INFO - 'download_minidump_stackwalk': True, 04:31:40 INFO - 'download_symbols': 'ondemand', 04:31:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:40 INFO - 'installer_path': 'installer.exe', 04:31:40 INFO - 'log_level': 'info', 04:31:40 INFO - 'log_name': 'talos', 04:31:40 INFO - 'log_to_console': True, 04:31:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:40 INFO - 'opt_config_files': (), 04:31:40 INFO - 'pip_index': False, 04:31:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:40 INFO - 'cmd': ('bash', 04:31:40 INFO - '-c', 04:31:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:40 INFO - 'enabled': True, 04:31:40 INFO - 'halt_on_failure': False, 04:31:40 INFO - 'name': 'check_screen_resolution'},), 04:31:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:40 INFO - 'cmd': ('bash', 04:31:40 INFO - '-c', 04:31:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:40 INFO - 'enabled': True, 04:31:40 INFO - 'halt_on_failure': False, 04:31:40 INFO - 'name': 'check_screen_resolution'},), 04:31:40 INFO - 'run_cmd_checks_enabled': True, 04:31:40 INFO - 'sps_profile': False, 04:31:40 INFO - 'sps_profile_interval': 0, 04:31:40 INFO - 'suite': 'dromaeojs', 04:31:40 INFO - 'system_bits': '32', 04:31:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:40 INFO - 'title': 't-yosemite-r7-0029', 04:31:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:40 INFO - 'use_talos_json': True, 04:31:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:40 INFO - 'work_dir': 'build'} 04:31:40 INFO - ##### 04:31:40 INFO - ##### Running clobber step. 04:31:40 INFO - ##### 04:31:40 INFO - Running pre-action listener: _resource_record_pre_action 04:31:40 INFO - Running main action method: clobber 04:31:40 INFO - rmtree: /builds/slave/test/build 04:31:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:42 INFO - Running post-action listener: _resource_record_post_action 04:31:42 INFO - ##### 04:31:42 INFO - ##### Running read-buildbot-config step. 04:31:42 INFO - ##### 04:31:42 INFO - Running pre-action listener: _resource_record_pre_action 04:31:42 INFO - Running main action method: read_buildbot_config 04:31:42 INFO - Using buildbot properties: 04:31:42 INFO - { 04:31:42 INFO - "project": "", 04:31:42 INFO - "product": "firefox", 04:31:42 INFO - "script_repo_revision": "production", 04:31:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:31:42 INFO - "repository": "", 04:31:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:31:42 INFO - "buildid": "20160206043136", 04:31:42 INFO - "stage_platform": "macosx64", 04:31:42 INFO - "basedir": "/builds/slave/test", 04:31:42 INFO - "buildnumber": 295, 04:31:42 INFO - "platform": "yosemite_r7", 04:31:42 INFO - "mozci_request": { 04:31:42 INFO - "priority": -1, 04:31:42 INFO - "type": "trigger_all_talos_jobs", 04:31:42 INFO - "times": 6 04:31:42 INFO - }, 04:31:42 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:31:42 INFO - "slavebuilddir": "test", 04:31:42 INFO - "branch": "fx-team", 04:31:42 INFO - "revision": "f5bd25c789b6", 04:31:42 INFO - "slavename": "t-yosemite-r7-0029", 04:31:42 INFO - "builduid": "3d198835ad75473f9a6d1fe3f25c3476", 04:31:42 INFO - "repo_path": "integration/fx-team" 04:31:42 INFO - } 04:31:42 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg. 04:31:42 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json. 04:31:42 INFO - Running post-action listener: _resource_record_post_action 04:31:42 INFO - ##### 04:31:42 INFO - ##### Running download-and-extract step. 04:31:42 INFO - ##### 04:31:42 INFO - Running pre-action listener: _resource_record_pre_action 04:31:42 INFO - Running main action method: download_and_extract 04:31:42 INFO - mkdir: /builds/slave/test/build/tests 04:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:42 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json 04:31:42 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json to /builds/slave/test/build/test_packages.json 04:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:31:42 INFO - Downloaded 1277 bytes. 04:31:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:31:42 INFO - Using the following test package requirements: 04:31:42 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:42 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:42 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:42 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:42 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:31:42 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:42 INFO - u'jsshell-mac.zip'], 04:31:42 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:42 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:31:42 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:42 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:42 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:31:42 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:42 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:31:42 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:42 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:31:42 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:42 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:42 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:42 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:42 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:43 INFO - Downloaded 17118738 bytes. 04:31:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:31:46 INFO - Return code: 0 04:31:46 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:50 INFO - Downloaded 17118738 bytes. 04:31:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:31:53 INFO - Return code: 0 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip 04:31:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:31:54 INFO - Downloaded 10706582 bytes. 04:31:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:31:54 INFO - Return code: 0 04:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:54 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:31:54 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:31:57 INFO - Downloaded 111115296 bytes. 04:31:57 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:31:57 INFO - mkdir: /builds/slave/test/properties 04:31:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:57 INFO - Contents: 04:31:57 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:31:57 INFO - Running post-action listener: _resource_record_post_action 04:31:57 INFO - Running post-action listener: set_extra_try_arguments 04:31:57 INFO - ##### 04:31:57 INFO - ##### Running populate-webroot step. 04:31:57 INFO - ##### 04:31:57 INFO - Running pre-action listener: _resource_record_pre_action 04:31:57 INFO - Running main action method: populate_webroot 04:31:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:57 INFO - '--tppagecycles', 04:31:57 INFO - '7'], 04:31:57 INFO - 'tests': ['tsvgm']}}, 04:31:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:31:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:31:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['damp', 'tps']}, 04:31:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['damp', 'tps']}, 04:31:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:31:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:57 INFO - 'other': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other_l64': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other_nol64': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'svgr': {'tests': ['tsvgx', 04:31:57 INFO - 'tsvgr_opacity', 04:31:57 INFO - 'tart', 04:31:57 INFO - 'tscrollx', 04:31:57 INFO - 'cart']}, 04:31:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tsvgx', 04:31:57 INFO - 'tsvgr_opacity', 04:31:57 INFO - 'tart', 04:31:57 INFO - 'tscrollx', 04:31:57 INFO - 'cart']}, 04:31:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['tp5o']}, 04:31:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tp5o']}, 04:31:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--xperf_path', 04:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:57 INFO - 'tests': ['tp5n']}, 04:31:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s', 04:31:57 INFO - '--xperf_path', 04:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:57 INFO - 'tests': ['tp5n']}}, 04:31:57 INFO - 'talos.zip': {'path': '', 04:31:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:57 INFO - Running post-action listener: _resource_record_post_action 04:31:57 INFO - ##### 04:31:57 INFO - ##### Running create-virtualenv step. 04:31:57 INFO - ##### 04:31:57 INFO - Running pre-action listener: _resource_record_pre_action 04:31:57 INFO - Running main action method: create_virtualenv 04:31:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:58 INFO - Using real prefix '/tools/python27' 04:31:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:01 INFO - Installing pip.................done. 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:01 INFO - 'HOME': '/Users/cltbld', 04:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PAGER': '/bin/cat', 04:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:01 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - 'XPC_FLAGS': '0x0', 04:32:01 INFO - 'XPC_SERVICE_NAME': '0', 04:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:32:01 INFO - Cleaning up... 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:01 INFO - 'HOME': '/Users/cltbld', 04:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PAGER': '/bin/cat', 04:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:01 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - 'XPC_FLAGS': '0x0', 04:32:01 INFO - 'XPC_SERVICE_NAME': '0', 04:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:02 INFO - Downloading/unpacking psutil>=0.7.1 04:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:05 INFO - Installing collected packages: psutil 04:32:05 INFO - Running setup.py install for psutil 04:32:05 INFO - building 'psutil._psutil_osx' extension 04:32:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:32:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:32:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:32:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:32:06 INFO - building 'psutil._psutil_posix' extension 04:32:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:32:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:06 INFO - ^ 04:32:06 INFO - 1 warning generated. 04:32:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:32:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:06 INFO - Successfully installed psutil 04:32:06 INFO - Cleaning up... 04:32:06 INFO - Return code: 0 04:32:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:06 INFO - 'HOME': '/Users/cltbld', 04:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PAGER': '/bin/cat', 04:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:06 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - 'XPC_FLAGS': '0x0', 04:32:06 INFO - 'XPC_SERVICE_NAME': '0', 04:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:32:09 INFO - Installing collected packages: mozsystemmonitor 04:32:09 INFO - Running setup.py install for mozsystemmonitor 04:32:09 INFO - Successfully installed mozsystemmonitor 04:32:09 INFO - Cleaning up... 04:32:09 INFO - Return code: 0 04:32:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:32:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:09 INFO - 'HOME': '/Users/cltbld', 04:32:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:09 INFO - 'LOGNAME': 'cltbld', 04:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:09 INFO - 'MOZ_NO_REMOTE': '1', 04:32:09 INFO - 'NO_EM_RESTART': '1', 04:32:09 INFO - 'PAGER': '/bin/cat', 04:32:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:09 INFO - 'PWD': '/builds/slave/test', 04:32:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:09 INFO - 'SHELL': '/bin/bash', 04:32:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:09 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:09 INFO - 'USER': 'cltbld', 04:32:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:09 INFO - 'XPC_FLAGS': '0x0', 04:32:09 INFO - 'XPC_SERVICE_NAME': '0', 04:32:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:13 INFO - Downloading docopt-0.6.1.tar.gz 04:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:13 INFO - Running setup.py install for blobuploader 04:32:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:13 INFO - Running setup.py install for requests 04:32:13 INFO - Running setup.py install for docopt 04:32:14 INFO - Successfully installed blobuploader requests docopt 04:32:14 INFO - Cleaning up... 04:32:14 INFO - Return code: 0 04:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:14 INFO - 'HOME': '/Users/cltbld', 04:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:14 INFO - 'LOGNAME': 'cltbld', 04:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:14 INFO - 'MOZ_NO_REMOTE': '1', 04:32:14 INFO - 'NO_EM_RESTART': '1', 04:32:14 INFO - 'PAGER': '/bin/cat', 04:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:14 INFO - 'PWD': '/builds/slave/test', 04:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:14 INFO - 'SHELL': '/bin/bash', 04:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:14 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:14 INFO - 'USER': 'cltbld', 04:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:14 INFO - 'XPC_FLAGS': '0x0', 04:32:14 INFO - 'XPC_SERVICE_NAME': '0', 04:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5uXDGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-3rNoZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-cxetIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-UQJap9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Sc_MeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-s_t6ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-3TV1zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-z3Bftz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-zuLzwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-mtRLi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-k6WzCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-CTJGcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5s0Iby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-lVidmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-f2i9Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hz1kt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-TOa3xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:16 INFO - Running setup.py install for manifestparser 04:32:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for mozcrash 04:32:16 INFO - Running setup.py install for mozdebug 04:32:16 INFO - Running setup.py install for mozdevice 04:32:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for mozfile 04:32:16 INFO - Running setup.py install for mozhttpd 04:32:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for mozinfo 04:32:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for mozInstall 04:32:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for mozleak 04:32:17 INFO - Running setup.py install for mozlog 04:32:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for moznetwork 04:32:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for mozprocess 04:32:17 INFO - Running setup.py install for mozprofile 04:32:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Running setup.py install for mozrunner 04:32:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Running setup.py install for mozscreenshot 04:32:18 INFO - Running setup.py install for moztest 04:32:18 INFO - Running setup.py install for mozversion 04:32:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:18 INFO - Cleaning up... 04:32:18 INFO - Return code: 0 04:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:18 INFO - 'HOME': '/Users/cltbld', 04:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:18 INFO - 'LOGNAME': 'cltbld', 04:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:18 INFO - 'MOZ_NO_REMOTE': '1', 04:32:18 INFO - 'NO_EM_RESTART': '1', 04:32:18 INFO - 'PAGER': '/bin/cat', 04:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:18 INFO - 'PWD': '/builds/slave/test', 04:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:18 INFO - 'SHELL': '/bin/bash', 04:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:18 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:18 INFO - 'USER': 'cltbld', 04:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:18 INFO - 'XPC_FLAGS': '0x0', 04:32:18 INFO - 'XPC_SERVICE_NAME': '0', 04:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:18 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-PvQUPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-59LgOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-6WMbLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-00C285-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-scCYJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-TPDVmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4tu0Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-KR8zZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dmffGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dEcCA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-CSaduq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-uYIqj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-v5A7qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-onXe9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-N9HBk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-m8Koju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-zv30LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:22 INFO - Downloading blessings-1.6.tar.gz 04:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:23 INFO - Installing collected packages: blessings 04:32:23 INFO - Running setup.py install for blessings 04:32:23 INFO - Successfully installed blessings 04:32:23 INFO - Cleaning up... 04:32:23 INFO - Return code: 0 04:32:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:23 INFO - Reading from file tmpfile_stdout 04:32:23 INFO - Current package versions: 04:32:23 INFO - blessings == 1.6 04:32:23 INFO - blobuploader == 1.2.4 04:32:23 INFO - docopt == 0.6.1 04:32:23 INFO - manifestparser == 1.1 04:32:23 INFO - mozInstall == 1.12 04:32:23 INFO - mozcrash == 0.16 04:32:23 INFO - mozdebug == 0.1 04:32:23 INFO - mozdevice == 0.48 04:32:23 INFO - mozfile == 1.2 04:32:23 INFO - mozhttpd == 0.7 04:32:23 INFO - mozinfo == 0.9 04:32:23 INFO - mozleak == 0.1 04:32:23 INFO - mozlog == 3.1 04:32:23 INFO - moznetwork == 0.27 04:32:23 INFO - mozprocess == 0.22 04:32:23 INFO - mozprofile == 0.28 04:32:23 INFO - mozrunner == 6.11 04:32:23 INFO - mozscreenshot == 0.1 04:32:23 INFO - mozsystemmonitor == 0.0 04:32:23 INFO - moztest == 0.7 04:32:23 INFO - mozversion == 1.4 04:32:23 INFO - psutil == 3.1.1 04:32:23 INFO - requests == 1.2.3 04:32:23 INFO - wsgiref == 0.1.2 04:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:23 INFO - 'HOME': '/Users/cltbld', 04:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:23 INFO - 'LOGNAME': 'cltbld', 04:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:23 INFO - 'MOZ_NO_REMOTE': '1', 04:32:23 INFO - 'NO_EM_RESTART': '1', 04:32:23 INFO - 'PAGER': '/bin/cat', 04:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:23 INFO - 'PWD': '/builds/slave/test', 04:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:23 INFO - 'SHELL': '/bin/bash', 04:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:23 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:23 INFO - 'USER': 'cltbld', 04:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:23 INFO - 'XPC_FLAGS': '0x0', 04:32:23 INFO - 'XPC_SERVICE_NAME': '0', 04:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:23 INFO - Cleaning up... 04:32:23 INFO - Return code: 0 04:32:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:23 INFO - 'HOME': '/Users/cltbld', 04:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:23 INFO - 'LOGNAME': 'cltbld', 04:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:23 INFO - 'MOZ_NO_REMOTE': '1', 04:32:23 INFO - 'NO_EM_RESTART': '1', 04:32:23 INFO - 'PAGER': '/bin/cat', 04:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:23 INFO - 'PWD': '/builds/slave/test', 04:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:23 INFO - 'SHELL': '/bin/bash', 04:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:23 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:23 INFO - 'USER': 'cltbld', 04:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:23 INFO - 'XPC_FLAGS': '0x0', 04:32:23 INFO - 'XPC_SERVICE_NAME': '0', 04:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:24 INFO - Downloading/unpacking jsonschema 04:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:26 INFO - Downloading/unpacking functools32 (from jsonschema) 04:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:26 INFO - warning: no files found matching '*.txt' 04:32:26 INFO - no previously-included directories found matching 'build' 04:32:26 INFO - no previously-included directories found matching 'dist' 04:32:26 INFO - no previously-included directories found matching '.git*' 04:32:26 INFO - Installing collected packages: jsonschema, functools32 04:32:26 INFO - Running setup.py install for functools32 04:32:27 INFO - warning: no files found matching '*.txt' 04:32:27 INFO - no previously-included directories found matching 'build' 04:32:27 INFO - no previously-included directories found matching 'dist' 04:32:27 INFO - no previously-included directories found matching '.git*' 04:32:27 INFO - Successfully installed jsonschema functools32 04:32:27 INFO - Cleaning up... 04:32:27 INFO - Return code: 0 04:32:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbe25b77f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:27 INFO - 'HOME': '/Users/cltbld', 04:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:27 INFO - 'LOGNAME': 'cltbld', 04:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:27 INFO - 'MOZ_NO_REMOTE': '1', 04:32:27 INFO - 'NO_EM_RESTART': '1', 04:32:27 INFO - 'PAGER': '/bin/cat', 04:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:27 INFO - 'PWD': '/builds/slave/test', 04:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:27 INFO - 'SHELL': '/bin/bash', 04:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:32:27 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:27 INFO - 'USER': 'cltbld', 04:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:27 INFO - 'XPC_FLAGS': '0x0', 04:32:27 INFO - 'XPC_SERVICE_NAME': '0', 04:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:27 INFO - Downloading/unpacking flake8 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:30 INFO - no previously-included directories found matching 'docs/_build' 04:32:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:31 INFO - Running setup.py install for pep8 04:32:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:31 INFO - no previously-included directories found matching 'docs/_build' 04:32:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:31 INFO - Cleaning up... 04:32:31 INFO - Return code: 0 04:32:31 INFO - Running post-action listener: _resource_record_post_action 04:32:31 INFO - Running post-action listener: _start_resource_monitoring 04:32:31 INFO - Starting resource monitoring. 04:32:31 INFO - ##### 04:32:31 INFO - ##### Running install step. 04:32:31 INFO - ##### 04:32:31 INFO - Running pre-action listener: _resource_record_pre_action 04:32:31 INFO - Running main action method: install 04:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:31 INFO - Reading from file tmpfile_stdout 04:32:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:31 INFO - Reading from file tmpfile_stdout 04:32:31 INFO - Output received: 04:32:31 INFO - Usage: mozinstall [options] installer 04:32:31 INFO - Options: 04:32:31 INFO - -h, --help show this help message and exit 04:32:31 INFO - -d DEST, --destination=DEST 04:32:31 INFO - Directory to install application into. [default: 04:32:31 INFO - "/builds/slave/test"] 04:32:31 INFO - --app=APP Application being installed. [default: firefox] 04:32:31 INFO - mkdir: /builds/slave/test/build/application 04:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:33:05 INFO - Reading from file tmpfile_stdout 04:33:05 INFO - Output received: 04:33:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:33:05 INFO - Running post-action listener: _resource_record_post_action 04:33:05 INFO - ##### 04:33:05 INFO - ##### Running run-tests step. 04:33:05 INFO - ##### 04:33:05 INFO - Running pre-action listener: _resource_record_pre_action 04:33:05 INFO - Running main action method: run_tests 04:33:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:05 INFO - 2016-02-06 04:33:05.355 screenresolution[1699:14686] starting screenresolution argv=screenresolution get 04:33:05 INFO - 2016-02-06 04:33:05.358 screenresolution[1699:14686] Display 0: 1600x1200x32@60 04:33:05 INFO - 2016-02-06 04:33:05.364 screenresolution[1700:14688] starting screenresolution argv=screenresolution list 04:33:05 INFO - Available Modes on Display 0 04:33:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:05 INFO - Intel Iris: 04:33:05 INFO - Chipset Model: Intel Iris 04:33:05 INFO - Type: GPU 04:33:05 INFO - Bus: Built-In 04:33:05 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:05 INFO - Vendor: Intel (0x8086) 04:33:05 INFO - Device ID: 0x0a2e 04:33:05 INFO - Revision ID: 0x0009 04:33:05 INFO - Displays: 04:33:05 INFO - Display: 04:33:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:05 INFO - Display Serial Number: 1600x1200 60 04:33:05 INFO - Main Display: Yes 04:33:05 INFO - Mirror: Off 04:33:05 INFO - Online: Yes 04:33:05 INFO - Rotation: Supported 04:33:05 INFO - Return code: 0 04:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:05 INFO - Python 2.7.3 04:33:05 INFO - Return code: 0 04:33:05 INFO - grabbing minidump binary from tooltool 04:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef48d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:33:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:33:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:05 INFO - Return code: 0 04:33:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:33:06 INFO - Return code: 0 04:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8RNxLFiRn6/Render', 04:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:06 INFO - 'HOME': '/Users/cltbld', 04:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:06 INFO - 'LOGNAME': 'cltbld', 04:33:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:06 INFO - 'MOZ_NO_REMOTE': '1', 04:33:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:06 INFO - 'NO_EM_RESTART': '1', 04:33:06 INFO - 'PAGER': '/bin/cat', 04:33:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:06 INFO - 'PWD': '/builds/slave/test', 04:33:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:06 INFO - 'SHELL': '/bin/bash', 04:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners', 04:33:06 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 04:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:06 INFO - 'USER': 'cltbld', 04:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:06 INFO - 'XPC_FLAGS': '0x0', 04:33:06 INFO - 'XPC_SERVICE_NAME': '0', 04:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:33:07 INFO - mozversion application_buildid: 20160203075643 04:33:07 INFO - mozversion application_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:07 INFO - mozversion application_display_name: Nightly 04:33:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:07 INFO - mozversion application_name: Firefox 04:33:07 INFO - mozversion application_remotingname: firefox 04:33:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:33:07 INFO - mozversion application_vendor: Mozilla 04:33:07 INFO - mozversion application_version: 47.0a1 04:33:07 INFO - mozversion platform_buildid: 20160203075643 04:33:07 INFO - mozversion platform_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:33:07 INFO - mozversion platform_version: 47.0a1 04:33:07 INFO - using testdate: 1454761987 04:33:07 INFO - actual date: 1454761987 04:33:07 INFO - starting webserver on 'localhost:49268' 04:33:07 INFO - SUITE-START | Running 2 tests 04:33:07 INFO - TEST-START | dromaeo_css 04:33:07 INFO - operating with platform_type : mac_ 04:33:07 INFO - Initialising browser for dromaeo_css test... 04:33:07 INFO - TEST-INFO | started process 1718 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpm3qR1w/profile http://localhost:49268/getInfo.html) 04:33:07 INFO - PROCESS | 1718 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:33:09 INFO - PROCESS | 1718 | __metrics Screen width/height:1600/1200 04:33:09 INFO - PROCESS | 1718 | colorDepth:24 04:33:09 INFO - PROCESS | 1718 | Browser inner width/height: 1024/689 04:33:09 INFO - PROCESS | 1718 | __metrics 04:33:09 INFO - PROCESS | 1718 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:33:09 INFO - PROCESS | 1718 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:10 INFO - TEST-INFO | 1718: exit 0 04:33:10 INFO - Browser initialized. 04:33:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:10 INFO - TEST-INFO | started process 1722 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpm3qR1w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:22 INFO - PROCESS | 1722 | RSS: Main: 242843648 04:33:22 INFO - PROCESS | 1722 | 04:34:19 INFO - PROCESS | 1722 | 1454762059115 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:36:24 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 04:36:25 INFO - PROCESS | 1722 | RSS: Main: 346705920 04:36:25 INFO - PROCESS | 1722 | 04:39:27 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 04:39:28 INFO - PROCESS | 1722 | RSS: Main: 380723200 04:39:28 INFO - PROCESS | 1722 | 04:42:30 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 04:42:31 INFO - PROCESS | 1722 | RSS: Main: 380170240 04:42:31 INFO - PROCESS | 1722 | 04:45:33 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 04:45:33 INFO - PROCESS | 1722 | RSS: Main: 335699968 04:45:33 INFO - PROCESS | 1722 | 04:48:36 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 04:48:37 INFO - PROCESS | 1722 | RSS: Main: 341643264 04:48:37 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 04:51:40 INFO - PROCESS | 1722 | RSS: Main: 380432384 04:51:40 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | __start_tp_report 04:51:40 INFO - PROCESS | 1722 | _x_x_mozilla_page_load 04:51:40 INFO - PROCESS | 1722 | _x_x_mozilla_page_load_details 04:51:40 INFO - PROCESS | 1722 | |i|pagename|runs| 04:51:40 INFO - PROCESS | 1722 | |0;dojo.html;3334.8332583370834;3416.3167366526686;3447.8622054721945;3458.9654103458975;3470.9652903470956;5448.536874365674;5545.694986775726;5569.498745112939;5569.52659023983;5571.637843540172;5529.087700529418;5572.498475137237;5585.162225666142;5591.832245032656;5593.552515798737;5068.822591209299;5088.4911508849;5111.7699703513435;5142.408623008346;5170.741462926858;5167.147420675584;5192.247124166994;5198.116320225552;5203.973980130113;5206.349206349207;5173.560247378978;5189.7405129743365;5191.558717509016;5198.064348417283;5202.401723801754;5101.795928162887;5159.458256883048;5165.66423182492;5184.507471790174;5188.377394712658;5091.261767043758;5128.512791284822;5190.662606930538;5210.973945130288;5213.765380557884;5510.173473978935;5555.3611334696625;5567.3040869891265;5572.721363931787;5593.188987596816;6120.60216085953;6158.291796443422;6166.044263139221;6173.845653858644;6192.102145188923;6055.882119310493;6098.311206366218;6118.694065296718;6121.724522396503;6179.598326108833;5687.687177205211;5703.201551782754;5712.685802280831;5730.398308177623;5776.393478684678;6205.317415084337;6213.627182369072;6218.22272215973;6223;6223.973044447615;5947.37552556984;6053.213082299273;6062;6072.696365181811;6108.725107370179;6170.598911070766;6184.165137706352;6203.906941395882;6204.100405441186;6219.937800621936;6092.329843717188;6133.785317513865;6139.386061393914;6141.723622437001;6144.201253837062;6029.186059881948;6111.470193407285;6122.2761798032625;6122.520135281246;6140.140380346755;4795.328653988445;4846.36997190363;4854.975725121422;4858.416989961227;4859.441164266154;4301;4339.34909763538;4353.73877567347;4359.912801743947;4365.628921541641;5685.118806584986;5687.857803554944;5702.087665973424;5703.315602127688;5716.142578613241;6068.180795592627;6145.385461453819;6150.938490615036;6168.321484636686;6190.1952746142715;4548.909021819545;5136.101182293084;5250.291210686585;5609.831705048855;5737.3688894221605;5264.552513036435;5281.471852814765;5310.336207974004;5329.840104796862;5333.546648534841;5184.870378240575;6191.504679625619;6229.345918678474;6244.313125556276;6258.906116408167;5995.250593675791;6139.508839292936;6158.445739883432;6171.290301615192;6175.351588083367;6165.691715414122;6197.194364732556;6264.812055638338;6269.467095296951;6293.118963345044;6090.056041313604;6116.052011938156;6119.938800611937;6124.38756124384;6131.233595800525;6014.0377539593455;6140.258857967814;6165.9691701543;6166.1983942087245;6167.784127555514;6005.759769609167;6016.729247183975;6048.12302216185;6062.181605483203;6118.47992920589;5565.415631358811;5950.137230101697;6020;6024.096385542204;6028.336882942785;5722.113072473773;5815.883682326415;5889.411058894248;5892.970535147297;5917.112433135064;5899;5958;6017.638941663514;6028.487578555872;6074.453299203093;5848.824535263949;5864.736086876015;5878.853028674146;5889;5896.7936122235515 04:51:40 INFO - PROCESS | 1722 | |1;ext.html;450.2773049255942;456.8355392058858;552.9852720258325;575.3412342867417;593.5755934506828;27106.051288204915;29716.55425168624;36672.08319792007;37334.4399834002;37460;41702.79148604253;42015.789921050426;42037;42038.73883783491;42081.368779468336;9431.056894310566;9644.951775241114;9645.855312170323;9647.131758141766;9655.32412731109;9632.47021413822;9768.413895166277;9777.168940640055;9802.166815820663;9855.063768941975;9745.415275083482;9793.461359625218;9807.92112867584;9809.901900981005;9824.901750982506;9678.95160524193;9685.564149613248;9733.2213422926;9769.218462522982;9770.120689137977;9400.15398614128;9491.952540237324;9524.999875013162;9544.904550954541;9548.856767148498;38743;39102.60897391018;39105;39214;39221.21557568861;3291.440455122635;3389.474631432132;3550.9644903550893;3666.3400587894166;3845.327067763158;22753.658695119586;27131.45737085267;27800.165995020183;27971;29213.853930730424;2415.7946574541184;2762.185155379168;2845.644294463192;2855.1434569629027;2855.9000434984678;484598;489225;489609;489948;490592.09407906176;62047.6897615518;62190.44523886939;62306.688466557374;62326.37673623206;62406.687966559875;65334;65711;65755.67122164358;65758.67120664366;65847.34152658412;16365.181740912907;16565.585860353345;16587.502374928772;16607.252673629715;16609.41867034648;12552.560660376843;12593.559225427067;12607.180533265491;12624.873751262554;12828.486860525662;18691.303877508617;19395;19536.31622893192;19538.023098845002;19552.515178442933;6576.868462630816;7824.92175078242;8123;8182.877256841033;8248.54632995179;984.7981163861391;984.9950750246203;990.4156547636928;1024;1108.14672702019;20607.381778546667;24182.637260441108;25553.8722306391;25945.09192178265;26035.869820650776;1016.6695823857276;1058.6718117383637;1119.269340974201;1146.1232157399595;1151.6487471321327;14063.929680351534;14145.151290922578;14445.422183112769;14455.49405770814;14489.275536223358;708442;715956;716068;717416;717531;48858;49419.50580494221;49457.50542494601;52543;53404;1422.3243959119336;1440.3230481673597;1444.3861358922416;1446.2262689461297;1552;27250.591241131002;27293;27669.58495622527;27933.860330698215;28543;43306.56693433152;46141.76929115333;46166.53833461623;52383.47616523786;53231.7338413321;423981;424060;431162;431306;431810;29917.401651967273;30328.241793955327;30351.848240759537;30372.84813575918;30420;42090.36864447097;42126;42277.5772242286;42743.3588496179;43401;28611.71388286174;35191.47212791861;35772.28455430929;35923.92228233157;36068.63931360653;34336.65663343335;35106.82446587751;35190.47214291839;35281.82359088188;35508;35180.648193517736;35462.46806297959;35482;35776;36359.63640363669;29590.704092958797;29713.257168570093;31158.844205778827;31163.532547012266;31456.74173033053;24075.518489629758;24149.517009659357;24160.758392416556;24566.877165614056;24650.137245196333 04:51:40 INFO - PROCESS | 1722 | |2;jquery.html;364.64811456944045;369.56576023172784;369.89827797355724;376.1611606118356;379.0277937091359;14485.420583176687;15015;18472.630547389042;18721.43835684928;19275.99999999998;15493.147876866768;18560;19017.904910475427;20206.39380818574;20234.696479552782;4480.775961201944;4781.306710526971;5519.365272993607;5642.492175704186;5650.3219613646215;4065.6544193743566;4271.402003719481;4275.230458517465;6000.399960003986;6280.806646737105;6023.789167379143;6126.0810878368375;6209.254889413254;6236.220472440945;6248.687565621701;5934.525237980951;6180.536459765491;6183.90724139136;6194.876102477948;6195.969020154916;5337.279467271907;5338.3593968724;5346.812861549827;5351.25082488452;5356.1430171172815;23350.64974025391;23882.402939926465;24200.15299464528;24390;24412;2286.565552545011;2314.895829687668;2356.304890057437;2579.7162312145647;2673.6123262126885;7098.7515436959975;7099.89350159748;13924.443022279096;14116.647083822987;14441.905923641118;1682.142107525171;1689.087892538028;1726.5844389096774;1758.824117588231;1778.2353587957173;85897;89486;96682;97954.51022744841;98477;8217.58912054395;8428.747137585882;9134.908650913405;10445.738856528496;10452.477376131163;12553.811692824615;12656.620301390973;12667.809982850265;12676.492940282285;12680.936595316964;8295.589749742558;8354.874676879852;8382.87425688615;8425.662973480992;8454.704085356983;8543.487390756574;8550.828983420297;8552.401331906707;8624.353173511887;8640.611172497252;5437.619366644297;5695.45893140151;5937.762489500458;6062.727177277033;6092.45167934888;1393.2476462710024;1705.2070787084065;1790.6329202513452;1794.9910250448925;1797.7842658881018;915.9313051521029;937.1940131486916;960.2989817433313;1021.8569400283966;1118.2228351295935;15903.52289431319;16573.254203560868;19406.865244823057;19508.12213450398;19895.502612434517;852.9402941794015;971.883373995111;975.0444564326999;990.6780296403698;1061.5117046158853;10581.84127238092;10861.402622855661;10872.836907446395;10919.781604367869;11124.666260012213;740318;745257;754891;769825;771703;92008.53995730112;96105;97651;98014.50992745133;98182;1176.7940610393148;1183.1363104933275;1191.386435985468;1191.4438078623389;1198.8501437320335;14789.778153327923;17496.91251543734;18064.277428903224;18105.547361316072;18338.72491912649;43238.135237294446;43634.56365436305;44489.44286949941;45112;45558.772206138754;60598;61880;63021.68489157525;63110.95112390906;63932.680336598016;7429.14564825052;7431.777046688608;7507.737229196952;7527.661255243636;7559.924400755922;11349.602763903224;11372.31766094037;11689.88310116888;11853.977235804814;12233.449494772578;6955.930440695731;8316.708915187939;9744.415335079917;9936.403815771077;10075.697729068139;6804.727810887707;8825.823483530165;9703.12671859536;10164.542595583069;10170.694879153638;8426.578671066545;10312.896871031493;10374.896251037393;10391.740206494898;10668.253222274367;6750.2237242715755;7366.8213085906;7428.405727541675;7570.886436703564;7697.191794861459;8634.956825215833;9737.123658870736;10336.17310615164;10354.844677329695;10401.58393664245 04:51:40 INFO - PROCESS | 1722 | |3;mootools.html;1402.7685431903737;1517.430963388729;1547.0253740143708;1790.9283628654855;1945.591425800581;7260.818479538014;8106.594670266485;8301.377396695249;8598.183172598609;8791.736247912557;8603.268722158607;8670.393072484929;8821.426607270523;8822.4706517609;8822.867656985134;2165.85921915075;2231.2190733243315;2413.9155129570468;2528.317354314334;2530.2409277216852;2239.899204535792;2400.435897564071;2458.6434966929783;2461.6676748638884;2466.950660986779;2456.3245107595376;2471.5551200783852;2474.7648973347505;2496.8501889886575;2497.775200231979;2453.435709786741;2464.7412021737637;2476.6037434010473;2486.415692312305;2493.925182244536;2439.42673471734;2459.8155138364696;2462.630605409185;2469.2098528470897;2470.4564995700916;8839.337049721233;8887.066857979884;8893.28853691703;8912.108789121035;8912.465252084896;5432.891342173174;5545.833624991256;5547.528460080898;5592.748326325325;5609.242752228438;3665.871694490707;3709.536307961505;3787.696984241254;3821.254855303217;3826.330392181357;1047.1047254597363;1062.3094988257694;1070.138538476526;1096.9890301096966;1098.3519723363174;12349.444275007556;12374.938125309405;12381.195222310611;12388;12398.194117382342;4919.573323736148;4930.9506904930495;5010.173321401928;5012.899742005139;5016.272640467185;10376.481175941173;10383.688489345332;10390.948045259725;10406.843897341547;10407.375557466576;5538.972305138448;5574.804881829116;5588.022096133161;5588.273524441796;5588.357338905997;4943.8516844494725;5071.822486213038;5086.796528138833;5109.693418394908;5115.948840511622;3642.453631955175;3730.9440358394645;3731.3470142724914;3993.740406873544;4041.636252737209;1286.3182513267982;1298.584632583394;1308.2869835939437;1319.630503459033;1320.1023304153268;1317.2425855133338;1341.4030756313348;1341.6042267530906;1342.2483409290828;1372.3618517389461;6981.860362792716;8153.918460815435;8225.177482251727;8426.915730842613;8480.915190848013;1194.199886076331;1198.2271434924426;1199.3943058755274;1207.836942012817;1216;6247.625142491465;6254.499640028786;6315.55791094619;6326.019466982625;6334.239891213084;10330.225233107547;10667.626633067961;10687.73280667974;10807.243492955575;10870.184736144663;10488;10732.141428685687;10841.566337346576;10844.728881778019;10849.132069434427;8351.248387645019;8389.622466988878;8394.034686011064;8408.201220884006;8435.536045517432;7628.694852205849;7844.09792873804;7911.011123609549;7945.324647405036;7994.5602991836;9623.615055397706;9637.9036209637;9653.2277417805;9750.561224744763;9821;9767.560459779184;10141.391516509033;10164.390136591828;10345.275830691779;10365.326253793479;6029.397060294111;7068.823279418056;7102.467314951503;7140.892886606809;7237.674304656198;7326.670299836626;7522.134954480305;7537.434692398202;8238.176182381714;8353.498790072616;7598.35413989795;7655.808604784925;7682.654280557276;7717.18969508216;7807.594632965894;7546.886796697944;7599.050118735158;7614.466987310835;7724.6910123594425;7746.341560967156;7642.197569255148;7710.997570316047;7714.922850771645;7738.7678369649;7758.883616745867;6993.055937448379;7034.47241456903;7036.648167591497;7126.109236345457;7127.7148914042855;6922.965385173042;7089.82275443118;7116.8932466014085;7184.281571842774;7234.5659260444545 04:51:40 INFO - PROCESS | 1722 | |4;prototype.html;290.9170886297404;316.99841500792496;317.23388017936685;328.6943142877125;336.9831508424578;5462.825492519108;6311.968440157799;6480.449161821245;6552.246491653461;6585.637789921552;5623.240862483563;5673.886522269562;6384.457321127709;6410.134631824702;6421.454176395012;4483.4171557697455;4568.794404251817;4577.359169716243;4745.999999999992;4788.880277993043;4608.5852273295395;4676.228422310314;4686.90626187476;4730.290456431529;4769.18923782956;4652.371929789486;4670.556297151765;4684.461286951993;4694.460137084227;4699.459562150362;4458.97770511147;4556.179887620227;4557.270836666117;4559.840405585822;4665.4168228971375;3960.2673505401594;3961.2473630010495;3980.5820388859042;3980.840766369342;3985.720999530034;5895.145203945447;5953.464188223037;6038.728257228435;6043.005808083322;6163.075538669235;5429.321334833146;5442.401335853053;5448.972755136238;5458.4541545845095;5460.453954604508;6037.064255040432;6205.100260462253;6510.121133646991;6747.359000894907;6802.693878775467;4427.026054268056;4427.048184640285;4429.844955426544;4430.26900561407;4431.911361772779;7087.255838136973;7153.070100886904;7165.140183178052;7167;7172.390346820474;4360.934585981213;4479.193745125908;4487.192305385062;4497.302918047708;4508.008238187594;4037.6877514807807;4305.397244385788;4571.9085618287445;4574.313852922021;4579.221532339444;4385.736855788663;4618.076384723069;5410.729463526808;5427.728613569306;5429.837104886859;6580.901286480706;6811.625360605214;6826.897596536056;6834.760783372558;6838.589684618939;1518.3015812726048;1581;1591.0294720220656;1592.1720705233213;1594.609320716432;988.2588058955783;995.3679413572434;999.8200323941614;1000.4297550396204;1006.3056491021172;6292.993121100602;6309.495240380758;6320.683965801692;6321;6339.936600634027;7050.5769653820935;7054.435645148375;7055.541389809646;7071.010058591802;7111.040009598742;6066.939330606638;6309.652969086653;6309.779157729549;6320.905186422207;6322.36776322364;3584.7849129052343;3667.2298817248143;3672.192117734094;3672.5042119313553;3794.4687743715904;7481.027466429329;7511.821571744133;7519.0225270715555;7520.586367749826;7521.323080922743;7114.826053701081;7399.038125043709;7403.259674032553;7415.59214243211;7432.442566807511;7457.813554661177;7492.400607951351;7548.962255188799;7554.395648348119;7557.790753479417;7184.784456466315;7198.6400679964745;7200.135983681992;7211.8557628848175;7215.67529461165;6832.214295355899;7078.539894906815;7099.716011359487;7101.467389945671;7108.395786358217;7522.548647081193;7524.05949256343;7526.9300942241325;7534.397248220239;7534.623268836426;3823.827927743314;4513.119941611486;4540.545945405565;4567.2920697291975;4572.771361431848;6306.46395056407;6451.774162909032;7125.287471252833;7135.929610558458;7171.569705817667;5642.266505354278;6843.520953533205;6911.343422374866;6912.827179320356;6913.308669133046;5534.7786088556;5855.94144058554;6881.311868813079;6895;6918.377346038881;6545.345465453416;6736.831579210559;6736.966315168393;6749.156355455568;6764.492663050192;6077.453029227391;6884.931150688429;6890.931090689029;6906.689198985957;6912.308769123048;4891.853244402673;5429.6199266051;6776.457883369417;6784.457243420613;6785.626790526371 04:51:40 INFO - PROCESS | 1722 | |5;yui.html;682.9897551536726;695.110258868648;704.1972151747009;754.5702836865291;789.7591234673422;14630.049046811962;15399.384024639015;15528.53414397567;15529.378824847021;15548.300326485307;14167.858321416783;14233.359498822552;14252.857471425283;14255.501057462965;14271;695.6834640238704;706.466617703633;709.0781983421557;854.1799872122754;867.8611422172454;792.8810678398229;820.979475513111;852.5055467828645;873.76845136039;879.0857508191473;915.6749353979342;919.3518569408584;919.4621146629197;920.9585568649393;921.0927236671873;715.2525610736792;734.9154847192588;736.4255880413286;893.0890491698431;907.5689047702355;670.0786418674322;672.237010992527;672.3948446398232;672.9831754206135;674.8717743628695;14813;14934.850651493454;14935.103893766409;14937.850621493862;14954.925225373912;12358.196717213352;12496.500139994389;12680.936595316964;12973.610791676265;13190.340482975813;10257.230707696952;10485.475726213659;11091.889081109166;11187.216894817366;11937.641870743892;3512.7365447591533;3561;3564.8752293669854;3589.0668426209113;3638.2359704462096;73156.1710957225;73554.63222683906;73928.15179620552;76023.61988190023;76388.23611763866;9667.371620844622;9690.224782017422;9747.658831940847;9782;9960.501974901226;21752;21928.671069933964;21955.451113722283;22031.118755249612;22133;7512.32389084985;7626.046744156981;7779.416543759241;7820.648070836826;7930.246626570467;4018.678505719535;4083.6528895044253;4085.1829634073306;4098.508179018537;4103.97948010258;3603.4955106285142;3664.413693809031;3666.6699997000396;3668.3763760160305;3676.356637588411;694.3438450664074;721.815936936078;722.1045903080247;729.5112274775913;732.7472022152349;506.1572481817806;553.4661188312573;555.3446932619547;585.833037584295;635.8537536366662;7167.534110282815;8312.958435207785;8544.658213671508;8568.957155214184;8667.869981950276;503.41100911933125;571.5170680774738;582.6271186440681;583.8102616649605;587.9911801322984;3937.125153910308;3992.7604343739467;4150.750954942713;4162.458880345535;4295.763732994716;85581.57209213915;86607;90628;90630;90689.54655226681;66309;70715;75756.62121689356;75910.62044689852;77004.61497692476;67435.66282168558;67550.64898701999;68538.65730671315;68640.65679671669;69743.3025669757;6911.75808846688;8709.346798989975;8713.564321784012;8807.212898453727;8913.930328360639;45912.31131532963;46129.538704612525;47317.76341118272;47921.76039119782;48176.5182348172;60568.39431605628;64470;66467;67133;67192.32807671861;9845.655402060893;10213.489325533843;10942.17933654963;10959.83560246581;11316.49075791575;11742.58900938463;12026.879731202926;12331.383430828602;12645.304508252135;12666.809997850223;10930.125589952944;11206.495707693337;11309.773804524028;11315.886841131813;11869.40652967331;9461.668841590512;11429.142814288794;11460.82808757886;11611.825822612836;12284.570040048555;6726.737515973711;10567.313124646873;10988.560457581607;11031.83452248233;11091.889081109408;9129.497877616795;9487.66793162236;9514.429134251966;9639.759006024906;9645.159047798821;8358.331333493428;9456.810863782548;9720.279720279721;10035.548400321857;10092.949535252277 04:51:40 INFO - PROCESS | 1722 | __end_tp_report 04:51:40 INFO - PROCESS | 1722 | __start_cc_report 04:51:40 INFO - PROCESS | 1722 | _x_x_mozilla_cycle_collect,1111 04:51:40 INFO - PROCESS | 1722 | __end_cc_report 04:51:40 INFO - PROCESS | 1722 | __startTimestamp1454763100740__endTimestamp 04:51:40 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | ------- Summary: start ------- 04:51:40 INFO - PROCESS | 1722 | Number of tests: 6 04:51:40 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | [#0] dojo.html Cycles:165 Average:5652.67 Median:5889.00 stddev:623.65 (10.6%) stddev-sans-first:598.47 04:51:40 INFO - PROCESS | 1722 | Values: 3334.8 3416.3 3447.9 3459.0 3471.0 5448.5 5545.7 5569.5 5569.5 5571.6 5529.1 5572.5 5585.2 5591.8 5593.6 5068.8 5088.5 5111.8 5142.4 5170.7 5167.1 5192.2 5198.1 5204.0 5206.3 5173.6 5189.7 5191.6 5198.1 5202.4 5101.8 5159.5 5165.7 5184.5 5188.4 5091.3 5128.5 5190.7 5211.0 5213.8 5510.2 5555.4 5567.3 5572.7 5593.2 6120.6 6158.3 6166.0 6173.8 6192.1 6055.9 6098.3 6118.7 6121.7 6179.6 5687.7 5703.2 5712.7 5730.4 5776.4 6205.3 6213.6 6218.2 6223.0 6224.0 5947.4 6053.2 6062.0 6072.7 6108.7 6170.6 6184.2 6203.9 6204.1 6219.9 6092.3 6133.8 6139.4 6141.7 6144.2 6029.2 6111.5 6122.3 6122.5 6140.1 4795.3 4846.4 4855.0 4858.4 4859.4 4301.0 4339.3 4353.7 4359.9 4365.6 5685.1 5687.9 5702.1 5703.3 5716.1 6068.2 6145.4 6150.9 6168.3 6190.2 4548.9 5136.1 5250.3 5609.8 5737.4 5264.6 5281.5 5310.3 5329.8 5333.5 5184.9 6191.5 6229.3 6244.3 6258.9 5995.3 6139.5 6158.4 6171.3 6175.4 6165.7 6197.2 6264.8 6269.5 6293.1 6090.1 6116.1 6119.9 6124.4 6131.2 6014.0 6140.3 6166.0 6166.2 6167.8 6005.8 6016.7 6048.1 6062.2 6118.5 5565.4 5950.1 6020.0 6024.1 6028.3 5722.1 5815.9 5889.4 5893.0 5917.1 5899.0 5958.0 6017.6 6028.5 6074.5 5848.8 5864.7 5878.9 5889.0 5896.8 04:51:40 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | [#1] ext.html Cycles:180 Average:67093.89 Median:20652.66 stddev:149578.83 (724.3%) stddev-sans-first:149914.74 04:51:40 INFO - PROCESS | 1722 | Values: 450.3 456.8 553.0 575.3 593.6 27106.1 29716.6 36672.1 37334.4 37460.0 41702.8 42015.8 42037.0 42038.7 42081.4 9431.1 9645.0 9645.9 9647.1 9655.3 9632.5 9768.4 9777.2 9802.2 9855.1 9745.4 9793.5 9807.9 9809.9 9824.9 9679.0 9685.6 9733.2 9769.2 9770.1 9400.2 9492.0 9525.0 9544.9 9548.9 38743.0 39102.6 39105.0 39214.0 39221.2 3291.4 3389.5 3551.0 3666.3 3845.3 22753.7 27131.5 27800.2 27971.0 29213.9 2415.8 2762.2 2845.6 2855.1 2855.9 484598.0 489225.0 489609.0 489948.0 490592.1 62047.7 62190.4 62306.7 62326.4 62406.7 65334.0 65711.0 65755.7 65758.7 65847.3 16365.2 16565.6 16587.5 16607.3 16609.4 12552.6 12593.6 12607.2 12624.9 12828.5 18691.3 19395.0 19536.3 19538.0 19552.5 6576.9 7824.9 8123.0 8182.9 8248.5 984.8 985.0 990.4 1024.0 1108.1 20607.4 24182.6 25553.9 25945.1 26035.9 1016.7 1058.7 1119.3 1146.1 1151.6 14063.9 14145.2 14445.4 14455.5 14489.3 708442.0 715956.0 716068.0 717416.0 717531.0 48858.0 49419.5 49457.5 52543.0 53404.0 1422.3 1440.3 1444.4 1446.2 1552.0 27250.6 27293.0 27669.6 27933.9 28543.0 43306.6 46141.8 46166.5 52383.5 53231.7 423981.0 424060.0 431162.0 431306.0 431810.0 29917.4 30328.2 30351.8 30372.8 30420.0 42090.4 42126.0 42277.6 42743.4 43401.0 28611.7 35191.5 35772.3 35923.9 36068.6 34336.7 35106.8 35190.5 35281.8 35508.0 35180.6 35462.5 35482.0 35776.0 36359.6 29590.7 29713.3 31158.8 31163.5 31456.7 24075.5 24149.5 24160.8 24566.9 24650.1 04:51:40 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | [#2] jquery.html Cycles:180 Average:36606.16 Median:45335.39 stddev:124104.01 (273.7%) stddev-sans-first:124422.31 04:51:40 INFO - PROCESS | 1722 | Values: 364.6 369.6 369.9 376.2 379.0 14485.4 15015.0 18472.6 18721.4 19276.0 15493.1 18560.0 19017.9 20206.4 20234.7 4480.8 4781.3 5519.4 5642.5 5650.3 4065.7 4271.4 4275.2 6000.4 6280.8 6023.8 6126.1 6209.3 6236.2 6248.7 5934.5 6180.5 6183.9 6194.9 6196.0 5337.3 5338.4 5346.8 5351.3 5356.1 23350.6 23882.4 24200.2 24390.0 24412.0 2286.6 2314.9 2356.3 2579.7 2673.6 7098.8 7099.9 13924.4 14116.6 14441.9 1682.1 1689.1 1726.6 1758.8 1778.2 85897.0 89486.0 96682.0 97954.5 98477.0 8217.6 8428.7 9134.9 10445.7 10452.5 12553.8 12656.6 12667.8 12676.5 12680.9 8295.6 8354.9 8382.9 8425.7 8454.7 8543.5 8550.8 8552.4 8624.4 8640.6 5437.6 5695.5 5937.8 6062.7 6092.5 1393.2 1705.2 1790.6 1795.0 1797.8 915.9 937.2 960.3 1021.9 1118.2 15903.5 16573.3 19406.9 19508.1 19895.5 852.9 971.9 975.0 990.7 1061.5 10581.8 10861.4 10872.8 10919.8 11124.7 740318.0 745257.0 754891.0 769825.0 771703.0 92008.5 96105.0 97651.0 98014.5 98182.0 1176.8 1183.1 1191.4 1191.4 1198.9 14789.8 17496.9 18064.3 18105.5 18338.7 43238.1 43634.6 44489.4 45112.0 45558.8 60598.0 61880.0 63021.7 63111.0 63932.7 7429.1 7431.8 7507.7 7527.7 7559.9 11349.6 11372.3 11689.9 11854.0 12233.4 6955.9 8316.7 9744.4 9936.4 10075.7 6804.7 8825.8 9703.1 10164.5 10170.7 8426.6 10312.9 10374.9 10391.7 10668.3 6750.2 7366.8 7428.4 7570.9 7697.2 8635.0 9737.1 10336.2 10354.8 10401.6 04:51:40 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | [#3] mootools.html Cycles:180 Average:6110.05 Median:5079.31 stddev:3218.35 (63.4%) stddev-sans-first:3207.92 04:51:40 INFO - PROCESS | 1722 | Values: 1402.8 1517.4 1547.0 1790.9 1945.6 7260.8 8106.6 8301.4 8598.2 8791.7 8603.3 8670.4 8821.4 8822.5 8822.9 2165.9 2231.2 2413.9 2528.3 2530.2 2239.9 2400.4 2458.6 2461.7 2467.0 2456.3 2471.6 2474.8 2496.9 2497.8 2453.4 2464.7 2476.6 2486.4 2493.9 2439.4 2459.8 2462.6 2469.2 2470.5 8839.3 8887.1 8893.3 8912.1 8912.5 5432.9 5545.8 5547.5 5592.7 5609.2 3665.9 3709.5 3787.7 3821.3 3826.3 1047.1 1062.3 1070.1 1097.0 1098.4 12349.4 12374.9 12381.2 12388.0 12398.2 4919.6 4931.0 5010.2 5012.9 5016.3 10376.5 10383.7 10390.9 10406.8 10407.4 5539.0 5574.8 5588.0 5588.3 5588.4 4943.9 5071.8 5086.8 5109.7 5115.9 3642.5 3730.9 3731.3 3993.7 4041.6 1286.3 1298.6 1308.3 1319.6 1320.1 1317.2 1341.4 1341.6 1342.2 1372.4 6981.9 8153.9 8225.2 8426.9 8480.9 1194.2 1198.2 1199.4 1207.8 1216.0 6247.6 6254.5 6315.6 6326.0 6334.2 10330.2 10667.6 10687.7 10807.2 10870.2 10488.0 10732.1 10841.6 10844.7 10849.1 8351.2 8389.6 8394.0 8408.2 8435.5 7628.7 7844.1 7911.0 7945.3 7994.6 9623.6 9637.9 9653.2 9750.6 9821.0 9767.6 10141.4 10164.4 10345.3 10365.3 6029.4 7068.8 7102.5 7140.9 7237.7 7326.7 7522.1 7537.4 8238.2 8353.5 7598.4 7655.8 7682.7 7717.2 7807.6 7546.9 7599.1 7614.5 7724.7 7746.3 7642.2 7711.0 7714.9 7738.8 7758.9 6993.1 7034.5 7036.6 7126.1 7127.7 6923.0 7089.8 7116.9 7184.3 7234.6 04:51:40 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | [#4] prototype.html Cycles:180 Average:5538.90 Median:6307.98 stddev:1805.81 (28.6%) stddev-sans-first:1767.39 04:51:40 INFO - PROCESS | 1722 | Values: 290.9 317.0 317.2 328.7 337.0 5462.8 6312.0 6480.4 6552.2 6585.6 5623.2 5673.9 6384.5 6410.1 6421.5 4483.4 4568.8 4577.4 4746.0 4788.9 4608.6 4676.2 4686.9 4730.3 4769.2 4652.4 4670.6 4684.5 4694.5 4699.5 4459.0 4556.2 4557.3 4559.8 4665.4 3960.3 3961.2 3980.6 3980.8 3985.7 5895.1 5953.5 6038.7 6043.0 6163.1 5429.3 5442.4 5449.0 5458.5 5460.5 6037.1 6205.1 6510.1 6747.4 6802.7 4427.0 4427.0 4429.8 4430.3 4431.9 7087.3 7153.1 7165.1 7167.0 7172.4 4360.9 4479.2 4487.2 4497.3 4508.0 4037.7 4305.4 4571.9 4574.3 4579.2 4385.7 4618.1 5410.7 5427.7 5429.8 6580.9 6811.6 6826.9 6834.8 6838.6 1518.3 1581.0 1591.0 1592.2 1594.6 988.3 995.4 999.8 1000.4 1006.3 6293.0 6309.5 6320.7 6321.0 6339.9 7050.6 7054.4 7055.5 7071.0 7111.0 6066.9 6309.7 6309.8 6320.9 6322.4 3584.8 3667.2 3672.2 3672.5 3794.5 7481.0 7511.8 7519.0 7520.6 7521.3 7114.8 7399.0 7403.3 7415.6 7432.4 7457.8 7492.4 7549.0 7554.4 7557.8 7184.8 7198.6 7200.1 7211.9 7215.7 6832.2 7078.5 7099.7 7101.5 7108.4 7522.5 7524.1 7526.9 7534.4 7534.6 3823.8 4513.1 4540.5 4567.3 4572.8 6306.5 6451.8 7125.3 7135.9 7171.6 5642.3 6843.5 6911.3 6912.8 6913.3 5534.8 5855.9 6881.3 6895.0 6918.4 6545.3 6736.8 6737.0 6749.2 6764.5 6077.5 6884.9 6890.9 6906.7 6912.3 4891.9 5429.6 6776.5 6784.5 6785.6 04:51:40 INFO - PROCESS | 1722 | 04:51:40 INFO - PROCESS | 1722 | [#5] yui.html Cycles:180 Average:17726.61 Median:65389.50 stddev:24367.58 (37.3%) stddev-sans-first:24402.33 04:51:40 INFO - PROCESS | 1722 | Values: 683.0 695.1 704.2 754.6 789.8 14630.0 15399.4 15528.5 15529.4 15548.3 14167.9 14233.4 14252.9 14255.5 14271.0 695.7 706.5 709.1 854.2 867.9 792.9 821.0 852.5 873.8 879.1 915.7 919.4 919.5 921.0 921.1 715.3 734.9 736.4 893.1 907.6 670.1 672.2 672.4 673.0 674.9 14813.0 14934.9 14935.1 14937.9 14954.9 12358.2 12496.5 12680.9 12973.6 13190.3 10257.2 10485.5 11091.9 11187.2 11937.6 3512.7 3561.0 3564.9 3589.1 3638.2 73156.2 73554.6 73928.2 76023.6 76388.2 9667.4 9690.2 9747.7 9782.0 9960.5 21752.0 21928.7 21955.5 22031.1 22133.0 7512.3 7626.0 7779.4 7820.6 7930.2 4018.7 4083.7 4085.2 4098.5 4104.0 3603.5 3664.4 3666.7 3668.4 3676.4 694.3 721.8 722.1 729.5 732.7 506.2 553.5 555.3 585.8 635.9 7167.5 8313.0 8544.7 8569.0 8667.9 503.4 571.5 582.6 583.8 588.0 3937.1 3992.8 4150.8 4162.5 4295.8 85581.6 86607.0 90628.0 90630.0 90689.5 66309.0 70715.0 75756.6 75910.6 77004.6 67435.7 67550.6 68538.7 68640.7 69743.3 6911.8 8709.3 8713.6 8807.2 8913.9 45912.3 46129.5 47317.8 47921.8 48176.5 60568.4 64470.0 66467.0 67133.0 67192.3 9845.7 10213.5 10942.2 10959.8 11316.5 11742.6 12026.9 12331.4 12645.3 12666.8 10930.1 11206.5 11309.8 11315.9 11869.4 9461.7 11429.1 11460.8 11611.8 12284.6 6726.7 10567.3 10988.6 11031.8 11091.9 9129.5 9487.7 9514.4 9639.8 9645.2 8358.3 9456.8 9720.3 10035.5 10092.9 04:51:40 INFO - PROCESS | 1722 | -------- Summary: end -------- 04:51:40 INFO - PROCESS | 1722 | 04:51:41 INFO - TEST-INFO | 1722: exit 0 04:51:41 INFO - TEST-OK | dromaeo_css | took 1114103ms 04:51:41 INFO - TEST-START | kraken 04:51:41 INFO - operating with platform_type : mac_ 04:51:41 INFO - Initialising browser for kraken test... 04:51:41 INFO - TEST-INFO | started process 1729 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpSwlJul/profile http://localhost:49268/getInfo.html) 04:51:41 INFO - PROCESS | 1729 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:51:43 INFO - PROCESS | 1729 | __metrics Screen width/height:1600/1200 04:51:43 INFO - PROCESS | 1729 | colorDepth:24 04:51:43 INFO - PROCESS | 1729 | Browser inner width/height: 1024/689 04:51:43 INFO - PROCESS | 1729 | __metrics 04:51:43 INFO - PROCESS | 1729 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:51:43 INFO - PROCESS | 1729 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:44 INFO - TEST-INFO | 1729: exit 0 04:51:44 INFO - Browser initialized. 04:51:44 INFO - Running cycle 1/1 for kraken test... 04:51:44 INFO - TEST-INFO | started process 1731 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpSwlJul/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:56 INFO - PROCESS | 1731 | RSS: Main: 243150848 04:51:56 INFO - PROCESS | 1731 | 04:51:58 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:59 INFO - PROCESS | 1731 | RSS: Main: 290664448 04:51:59 INFO - PROCESS | 1731 | 04:52:02 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 04:52:02 INFO - PROCESS | 1731 | RSS: Main: 300228608 04:52:02 INFO - PROCESS | 1731 | 04:52:05 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 04:52:06 INFO - PROCESS | 1731 | RSS: Main: 287006720 04:52:06 INFO - PROCESS | 1731 | 04:52:08 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 04:52:08 INFO - PROCESS | 1731 | RSS: Main: 288395264 04:52:08 INFO - PROCESS | 1731 | 04:52:11 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:11 INFO - PROCESS | 1731 | RSS: Main: 289783808 04:52:11 INFO - PROCESS | 1731 | 04:52:14 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:15 INFO - PROCESS | 1731 | RSS: Main: 289624064 04:52:15 INFO - PROCESS | 1731 | 04:52:18 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:18 INFO - PROCESS | 1731 | RSS: Main: 289808384 04:52:18 INFO - PROCESS | 1731 | 04:52:21 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 04:52:21 INFO - PROCESS | 1731 | RSS: Main: 290209792 04:52:21 INFO - PROCESS | 1731 | 04:52:23 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:24 INFO - PROCESS | 1731 | RSS: Main: 325869568 04:52:24 INFO - PROCESS | 1731 | 04:52:25 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:26 INFO - PROCESS | 1731 | RSS: Main: 325971968 04:52:26 INFO - PROCESS | 1731 | 04:52:28 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:29 INFO - PROCESS | 1731 | RSS: Main: 331350016 04:52:29 INFO - PROCESS | 1731 | 04:52:31 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:32 INFO - PROCESS | 1731 | RSS: Main: 332627968 04:52:32 INFO - PROCESS | 1731 | 04:52:34 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:35 INFO - PROCESS | 1731 | RSS: Main: 332812288 04:52:35 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 04:52:37 INFO - PROCESS | 1731 | RSS: Main: 393465856 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | __start_tp_report 04:52:37 INFO - PROCESS | 1731 | _x_x_mozilla_page_load 04:52:37 INFO - PROCESS | 1731 | _x_x_mozilla_page_load_details 04:52:37 INFO - PROCESS | 1731 | |i|pagename|runs| 04:52:37 INFO - PROCESS | 1731 | |0;ai-astar;111;107;110;110;111;111;117;109;111;110 04:52:37 INFO - PROCESS | 1731 | |1;audio-beat-detection;181;160;166;156;121;142;140;120;160;112 04:52:37 INFO - PROCESS | 1731 | |2;audio-dft;186;182;183;185;185;183;183;180;180;183 04:52:37 INFO - PROCESS | 1731 | |3;audio-fft;79;71;84;76;57;57;57;75;74;61 04:52:37 INFO - PROCESS | 1731 | |4;audio-oscillator;95;93;129;83;115;122;129;75;77;109 04:52:37 INFO - PROCESS | 1731 | |5;imaging-gaussian-blur;117;93;72;137;133;94;85;92;83;90 04:52:37 INFO - PROCESS | 1731 | |6;imaging-darkroom;93;93;101;106;93;93;92;92;93;93 04:52:37 INFO - PROCESS | 1731 | |7;imaging-desaturate;86;93;122;84;84;86;87;85;86;86 04:52:37 INFO - PROCESS | 1731 | |8;json-parse-financial;55;53;53;52;52;53;54;64;52;50 04:52:37 INFO - PROCESS | 1731 | |9;json-stringify-tinderbox;64;69;66;75;70;66;66;66;65;69 04:52:37 INFO - PROCESS | 1731 | |10;stanford-crypto-aes;85;83;83;81;82;81;82;82;83;82 04:52:37 INFO - PROCESS | 1731 | |11;stanford-crypto-ccm;123;126;125;119;119;122;123;123;135;120 04:52:37 INFO - PROCESS | 1731 | |12;stanford-crypto-pbkdf2;137;105;161;176;178;149;138;166;132;143 04:52:37 INFO - PROCESS | 1731 | |13;stanford-crypto-sha256-iterative;67;69;74;97;98;100;70;66;66;65 04:52:37 INFO - PROCESS | 1731 | __end_tp_report 04:52:37 INFO - PROCESS | 1731 | __start_cc_report 04:52:37 INFO - PROCESS | 1731 | _x_x_mozilla_cycle_collect,1195 04:52:37 INFO - PROCESS | 1731 | __end_cc_report 04:52:37 INFO - PROCESS | 1731 | __startTimestamp1454763157536__endTimestamp 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | ------- Summary: start ------- 04:52:37 INFO - PROCESS | 1731 | Number of tests: 14 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.54 (2.3%) stddev-sans-first:2.69 04:52:37 INFO - PROCESS | 1731 | Values: 111.0 107.0 110.0 110.0 111.0 111.0 117.0 109.0 111.0 110.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:158.00 stddev:22.67 (14.3%) stddev-sans-first:20.15 04:52:37 INFO - PROCESS | 1731 | Values: 181.0 160.0 166.0 156.0 121.0 142.0 140.0 120.0 160.0 112.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:2.00 (1.1%) stddev-sans-first:1.80 04:52:37 INFO - PROCESS | 1731 | Values: 186.0 182.0 183.0 185.0 185.0 183.0 183.0 180.0 180.0 183.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#3] audio-fft Cycles:10 Average:69.10 Median:74.50 stddev:10.19 (13.7%) stddev-sans-first:10.16 04:52:37 INFO - PROCESS | 1731 | Values: 79.0 71.0 84.0 76.0 57.0 57.0 57.0 75.0 74.0 61.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:76.00 stddev:20.86 (27.4%) stddev-sans-first:21.94 04:52:37 INFO - PROCESS | 1731 | Values: 95.0 93.0 129.0 83.0 115.0 122.0 129.0 75.0 77.0 109.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#5] imaging-gaussian-blur Cycles:10 Average:99.60 Median:87.50 stddev:21.84 (25.0%) stddev-sans-first:22.24 04:52:37 INFO - PROCESS | 1731 | Values: 117.0 93.0 72.0 137.0 133.0 94.0 85.0 92.0 83.0 90.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:93.00 stddev:4.70 (5.1%) stddev-sans-first:4.94 04:52:37 INFO - PROCESS | 1731 | Values: 93.0 93.0 101.0 106.0 93.0 93.0 92.0 92.0 93.0 93.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#7] imaging-desaturate Cycles:10 Average:89.90 Median:86.00 stddev:11.56 (13.4%) stddev-sans-first:12.18 04:52:37 INFO - PROCESS | 1731 | Values: 86.0 93.0 122.0 84.0 84.0 86.0 87.0 85.0 86.0 86.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.00 stddev:3.82 (7.2%) stddev-sans-first:4.03 04:52:37 INFO - PROCESS | 1731 | Values: 55.0 53.0 53.0 52.0 52.0 53.0 54.0 64.0 52.0 50.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:3.24 (4.8%) stddev-sans-first:3.16 04:52:37 INFO - PROCESS | 1731 | Values: 64.0 69.0 66.0 75.0 70.0 66.0 66.0 66.0 65.0 69.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.17 (1.4%) stddev-sans-first:0.78 04:52:37 INFO - PROCESS | 1731 | Values: 85.0 83.0 83.0 81.0 82.0 81.0 82.0 82.0 83.0 82.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:123.00 stddev:4.67 (3.8%) stddev-sans-first:4.95 04:52:37 INFO - PROCESS | 1731 | Values: 123.0 126.0 125.0 119.0 119.0 122.0 123.0 123.0 135.0 120.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:155.00 stddev:22.43 (14.5%) stddev-sans-first:23.40 04:52:37 INFO - PROCESS | 1731 | Values: 137.0 105.0 161.0 176.0 178.0 149.0 138.0 166.0 132.0 143.0 04:52:37 INFO - PROCESS | 1731 | 04:52:37 INFO - PROCESS | 1731 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.20 Median:69.50 stddev:14.82 (21.3%) stddev-sans-first:15.26 04:52:37 INFO - PROCESS | 1731 | Values: 67.0 69.0 74.0 97.0 98.0 100.0 70.0 66.0 66.0 65.0 04:52:37 INFO - PROCESS | 1731 | -------- Summary: end -------- 04:52:37 INFO - PROCESS | 1731 | 04:52:38 INFO - TEST-INFO | 1731: exit 0 04:52:38 INFO - TEST-OK | kraken | took 56969ms 04:52:38 INFO - SUITE-END | took 1171s 04:52:38 INFO - Completed test suite (00:19:31) 04:52:38 INFO - Working with test: dromaeo_css 04:52:38 INFO - Generating results file: dromaeo_css 04:52:38 INFO - Working with test: kraken 04:52:38 INFO - Generating results file: kraken 04:52:38 INFO - javascript benchmark 04:52:38 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:52:38 INFO - process_Request line: dromaeo_css 7399.83 graph.html#tests=[[72,64,59]] 04:52:38 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:38 INFO - process_Request line: kraken 1448.70 graph.html#tests=[[232,64,59]] 04:52:38 INFO - RETURN: dromaeo_css: 7399.83 04:52:38 INFO - RETURN: kraken: 1448.70 04:52:38 INFO - javascript benchmark 04:52:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3334.8332583370834, 3416.3167366526686, 3447.8622054721945, 3458.9654103458975, 3470.9652903470956, 5448.536874365674, 5545.694986775726, 5569.498745112939, 5569.52659023983, 5571.637843540172, 5529.087700529418, 5572.498475137237, 5585.162225666142, 5591.832245032656, 5593.552515798737, 5068.822591209299, 5088.4911508849, 5111.7699703513435, 5142.408623008346, 5170.741462926858, 5167.147420675584, 5192.247124166994, 5198.116320225552, 5203.973980130113, 5206.349206349207, 5173.560247378978, 5189.7405129743365, 5191.558717509016, 5198.064348417283, 5202.401723801754, 5101.795928162887, 5159.458256883048, 5165.66423182492, 5184.507471790174, 5188.377394712658, 5091.261767043758, 5128.512791284822, 5190.662606930538, 5210.973945130288, 5213.765380557884, 5510.173473978935, 5555.3611334696625, 5567.3040869891265, 5572.721363931787, 5593.188987596816, 6120.60216085953, 6158.291796443422, 6166.044263139221, 6173.845653858644, 6192.102145188923, 6055.882119310493, 6098.311206366218, 6118.694065296718, 6121.724522396503, 6179.598326108833, 5687.687177205211, 5703.201551782754, 5712.685802280831, 5730.398308177623, 5776.393478684678, 6205.317415084337, 6213.627182369072, 6218.22272215973, 6223.0, 6223.973044447615, 5947.37552556984, 6053.213082299273, 6062.0, 6072.696365181811, 6108.725107370179, 6170.598911070766, 6184.165137706352, 6203.906941395882, 6204.100405441186, 6219.937800621936, 6092.329843717188, 6133.785317513865, 6139.386061393914, 6141.723622437001, 6144.201253837062, 6029.186059881948, 6111.470193407285, 6122.2761798032625, 6122.520135281246, 6140.140380346755, 4795.328653988445, 4846.36997190363, 4854.975725121422, 4858.416989961227, 4859.441164266154, 4301.0, 4339.34909763538, 4353.73877567347, 4359.912801743947, 4365.628921541641, 5685.118806584986, 5687.857803554944, 5702.087665973424, 5703.315602127688, 5716.142578613241, 6068.180795592627, 6145.385461453819, 6150.938490615036, 6168.321484636686, 6190.1952746142715, 4548.909021819545, 5136.101182293084, 5250.291210686585, 5609.831705048855, 5737.3688894221605, 5264.552513036435, 5281.471852814765, 5310.336207974004, 5329.840104796862, 5333.546648534841, 5184.870378240575, 6191.504679625619, 6229.345918678474, 6244.313125556276, 6258.906116408167, 5995.250593675791, 6139.508839292936, 6158.445739883432, 6171.290301615192, 6175.351588083367, 6165.691715414122, 6197.194364732556, 6264.812055638338, 6269.467095296951, 6293.118963345044, 6090.056041313604, 6116.052011938156, 6119.938800611937, 6124.38756124384, 6131.233595800525, 6014.0377539593455, 6140.258857967814, 6165.9691701543, 6166.1983942087245, 6167.784127555514, 6005.759769609167, 6016.729247183975, 6048.12302216185, 6062.181605483203, 6118.47992920589, 5565.415631358811, 5950.137230101697, 6020.0, 6024.096385542204, 6028.336882942785, 5722.113072473773, 5815.883682326415, 5889.411058894248, 5892.970535147297, 5917.112433135064, 5899.0, 5958.0, 6017.638941663514, 6028.487578555872, 6074.453299203093, 5848.824535263949, 5864.736086876015, 5878.853028674146, 5889.0, 5896.7936122235515], "unit": "score", "name": "dojo.html", "value": 5613.957668387929}, {"lowerIsBetter": false, "replicates": [450.2773049255942, 456.8355392058858, 552.9852720258325, 575.3412342867417, 593.5755934506828, 27106.051288204915, 29716.55425168624, 36672.08319792007, 37334.4399834002, 37460.0, 41702.79148604253, 42015.789921050426, 42037.0, 42038.73883783491, 42081.368779468336, 9431.056894310566, 9644.951775241114, 9645.855312170323, 9647.131758141766, 9655.32412731109, 9632.47021413822, 9768.413895166277, 9777.168940640055, 9802.166815820663, 9855.063768941975, 9745.415275083482, 9793.461359625218, 9807.92112867584, 9809.901900981005, 9824.901750982506, 9678.95160524193, 9685.564149613248, 9733.2213422926, 9769.218462522982, 9770.120689137977, 9400.15398614128, 9491.952540237324, 9524.999875013162, 9544.904550954541, 9548.856767148498, 38743.0, 39102.60897391018, 39105.0, 39214.0, 39221.21557568861, 3291.440455122635, 3389.474631432132, 3550.9644903550893, 3666.3400587894166, 3845.327067763158, 22753.658695119586, 27131.45737085267, 27800.165995020183, 27971.0, 29213.853930730424, 2415.7946574541184, 2762.185155379168, 2845.644294463192, 2855.1434569629027, 2855.9000434984678, 484598.0, 489225.0, 489609.0, 489948.0, 490592.09407906176, 62047.6897615518, 62190.44523886939, 62306.688466557374, 62326.37673623206, 62406.687966559875, 65334.0, 65711.0, 65755.67122164358, 65758.67120664366, 65847.34152658412, 16365.181740912907, 16565.585860353345, 16587.502374928772, 16607.252673629715, 16609.41867034648, 12552.560660376843, 12593.559225427067, 12607.180533265491, 12624.873751262554, 12828.486860525662, 18691.303877508617, 19395.0, 19536.31622893192, 19538.023098845002, 19552.515178442933, 6576.868462630816, 7824.92175078242, 8123.0, 8182.877256841033, 8248.54632995179, 984.7981163861391, 984.9950750246203, 990.4156547636928, 1024.0, 1108.14672702019, 20607.381778546667, 24182.637260441108, 25553.8722306391, 25945.09192178265, 26035.869820650776, 1016.6695823857276, 1058.6718117383637, 1119.269340974201, 1146.1232157399595, 1151.6487471321327, 14063.929680351534, 14145.151290922578, 14445.422183112769, 14455.49405770814, 14489.275536223358, 708442.0, 715956.0, 716068.0, 717416.0, 717531.0, 48858.0, 49419.50580494221, 49457.50542494601, 52543.0, 53404.0, 1422.3243959119336, 1440.3230481673597, 1444.3861358922416, 1446.2262689461297, 1552.0, 27250.591241131002, 27293.0, 27669.58495622527, 27933.860330698215, 28543.0, 43306.56693433152, 46141.76929115333, 46166.53833461623, 52383.47616523786, 53231.7338413321, 423981.0, 424060.0, 431162.0, 431306.0, 431810.0, 29917.401651967273, 30328.241793955327, 30351.848240759537, 30372.84813575918, 30420.0, 42090.36864447097, 42126.0, 42277.5772242286, 42743.3588496179, 43401.0, 28611.71388286174, 35191.47212791861, 35772.28455430929, 35923.92228233157, 36068.63931360653, 34336.65663343335, 35106.82446587751, 35190.47214291839, 35281.82359088188, 35508.0, 35180.648193517736, 35462.46806297959, 35482.0, 35776.0, 36359.63640363669, 29590.704092958797, 29713.257168570093, 31158.844205778827, 31163.532547012266, 31456.74173033053, 24075.518489629758, 24149.517009659357, 24160.758392416556, 24566.877165614056, 24650.137245196333], "unit": "score", "name": "ext.html", "value": 19329.131035975686}, {"lowerIsBetter": false, "replicates": [364.64811456944045, 369.56576023172784, 369.89827797355724, 376.1611606118356, 379.0277937091359, 14485.420583176687, 15015.0, 18472.630547389042, 18721.43835684928, 19275.99999999998, 15493.147876866768, 18560.0, 19017.904910475427, 20206.39380818574, 20234.696479552782, 4480.775961201944, 4781.306710526971, 5519.365272993607, 5642.492175704186, 5650.3219613646215, 4065.6544193743566, 4271.402003719481, 4275.230458517465, 6000.399960003986, 6280.806646737105, 6023.789167379143, 6126.0810878368375, 6209.254889413254, 6236.220472440945, 6248.687565621701, 5934.525237980951, 6180.536459765491, 6183.90724139136, 6194.876102477948, 6195.969020154916, 5337.279467271907, 5338.3593968724, 5346.812861549827, 5351.25082488452, 5356.1430171172815, 23350.64974025391, 23882.402939926465, 24200.15299464528, 24390.0, 24412.0, 2286.565552545011, 2314.895829687668, 2356.304890057437, 2579.7162312145647, 2673.6123262126885, 7098.7515436959975, 7099.89350159748, 13924.443022279096, 14116.647083822987, 14441.905923641118, 1682.142107525171, 1689.087892538028, 1726.5844389096774, 1758.824117588231, 1778.2353587957173, 85897.0, 89486.0, 96682.0, 97954.51022744841, 98477.0, 8217.58912054395, 8428.747137585882, 9134.908650913405, 10445.738856528496, 10452.477376131163, 12553.811692824615, 12656.620301390973, 12667.809982850265, 12676.492940282285, 12680.936595316964, 8295.589749742558, 8354.874676879852, 8382.87425688615, 8425.662973480992, 8454.704085356983, 8543.487390756574, 8550.828983420297, 8552.401331906707, 8624.353173511887, 8640.611172497252, 5437.619366644297, 5695.45893140151, 5937.762489500458, 6062.727177277033, 6092.45167934888, 1393.2476462710024, 1705.2070787084065, 1790.6329202513452, 1794.9910250448925, 1797.7842658881018, 915.9313051521029, 937.1940131486916, 960.2989817433313, 1021.8569400283966, 1118.2228351295935, 15903.52289431319, 16573.254203560868, 19406.865244823057, 19508.12213450398, 19895.502612434517, 852.9402941794015, 971.883373995111, 975.0444564326999, 990.6780296403698, 1061.5117046158853, 10581.84127238092, 10861.402622855661, 10872.836907446395, 10919.781604367869, 11124.666260012213, 740318.0, 745257.0, 754891.0, 769825.0, 771703.0, 92008.53995730112, 96105.0, 97651.0, 98014.50992745133, 98182.0, 1176.7940610393148, 1183.1363104933275, 1191.386435985468, 1191.4438078623389, 1198.8501437320335, 14789.778153327923, 17496.91251543734, 18064.277428903224, 18105.547361316072, 18338.72491912649, 43238.135237294446, 43634.56365436305, 44489.44286949941, 45112.0, 45558.772206138754, 60598.0, 61880.0, 63021.68489157525, 63110.95112390906, 63932.680336598016, 7429.14564825052, 7431.777046688608, 7507.737229196952, 7527.661255243636, 7559.924400755922, 11349.602763903224, 11372.31766094037, 11689.88310116888, 11853.977235804814, 12233.449494772578, 6955.930440695731, 8316.708915187939, 9744.415335079917, 9936.403815771077, 10075.697729068139, 6804.727810887707, 8825.823483530165, 9703.12671859536, 10164.542595583069, 10170.694879153638, 8426.578671066545, 10312.896871031493, 10374.896251037393, 10391.740206494898, 10668.253222274367, 6750.2237242715755, 7366.8213085906, 7428.405727541675, 7570.886436703564, 7697.191794861459, 8634.956825215833, 9737.123658870736, 10336.17310615164, 10354.844677329695, 10401.58393664245], "unit": "score", "name": "jquery.html", "value": 9016.703490671549}, {"lowerIsBetter": false, "replicates": [1402.7685431903737, 1517.430963388729, 1547.0253740143708, 1790.9283628654855, 1945.591425800581, 7260.818479538014, 8106.594670266485, 8301.377396695249, 8598.183172598609, 8791.736247912557, 8603.268722158607, 8670.393072484929, 8821.426607270523, 8822.4706517609, 8822.867656985134, 2165.85921915075, 2231.2190733243315, 2413.9155129570468, 2528.317354314334, 2530.2409277216852, 2239.899204535792, 2400.435897564071, 2458.6434966929783, 2461.6676748638884, 2466.950660986779, 2456.3245107595376, 2471.5551200783852, 2474.7648973347505, 2496.8501889886575, 2497.775200231979, 2453.435709786741, 2464.7412021737637, 2476.6037434010473, 2486.415692312305, 2493.925182244536, 2439.42673471734, 2459.8155138364696, 2462.630605409185, 2469.2098528470897, 2470.4564995700916, 8839.337049721233, 8887.066857979884, 8893.28853691703, 8912.108789121035, 8912.465252084896, 5432.891342173174, 5545.833624991256, 5547.528460080898, 5592.748326325325, 5609.242752228438, 3665.871694490707, 3709.536307961505, 3787.696984241254, 3821.254855303217, 3826.330392181357, 1047.1047254597363, 1062.3094988257694, 1070.138538476526, 1096.9890301096966, 1098.3519723363174, 12349.444275007556, 12374.938125309405, 12381.195222310611, 12388.0, 12398.194117382342, 4919.573323736148, 4930.9506904930495, 5010.173321401928, 5012.899742005139, 5016.272640467185, 10376.481175941173, 10383.688489345332, 10390.948045259725, 10406.843897341547, 10407.375557466576, 5538.972305138448, 5574.804881829116, 5588.022096133161, 5588.273524441796, 5588.357338905997, 4943.8516844494725, 5071.822486213038, 5086.796528138833, 5109.693418394908, 5115.948840511622, 3642.453631955175, 3730.9440358394645, 3731.3470142724914, 3993.740406873544, 4041.636252737209, 1286.3182513267982, 1298.584632583394, 1308.2869835939437, 1319.630503459033, 1320.1023304153268, 1317.2425855133338, 1341.4030756313348, 1341.6042267530906, 1342.2483409290828, 1372.3618517389461, 6981.860362792716, 8153.918460815435, 8225.177482251727, 8426.915730842613, 8480.915190848013, 1194.199886076331, 1198.2271434924426, 1199.3943058755274, 1207.836942012817, 1216.0, 6247.625142491465, 6254.499640028786, 6315.55791094619, 6326.019466982625, 6334.239891213084, 10330.225233107547, 10667.626633067961, 10687.73280667974, 10807.243492955575, 10870.184736144663, 10488.0, 10732.141428685687, 10841.566337346576, 10844.728881778019, 10849.132069434427, 8351.248387645019, 8389.622466988878, 8394.034686011064, 8408.201220884006, 8435.536045517432, 7628.694852205849, 7844.09792873804, 7911.011123609549, 7945.324647405036, 7994.5602991836, 9623.615055397706, 9637.9036209637, 9653.2277417805, 9750.561224744763, 9821.0, 9767.560459779184, 10141.391516509033, 10164.390136591828, 10345.275830691779, 10365.326253793479, 6029.397060294111, 7068.823279418056, 7102.467314951503, 7140.892886606809, 7237.674304656198, 7326.670299836626, 7522.134954480305, 7537.434692398202, 8238.176182381714, 8353.498790072616, 7598.35413989795, 7655.808604784925, 7682.654280557276, 7717.18969508216, 7807.594632965894, 7546.886796697944, 7599.050118735158, 7614.466987310835, 7724.6910123594425, 7746.341560967156, 7642.197569255148, 7710.997570316047, 7714.922850771645, 7738.7678369649, 7758.883616745867, 6993.055937448379, 7034.47241456903, 7036.648167591497, 7126.109236345457, 7127.7148914042855, 6922.965385173042, 7089.82275443118, 7116.8932466014085, 7184.281571842774, 7234.5659260444545], "unit": "score", "name": "mootools.html", "value": 4992.599461312737}, {"lowerIsBetter": false, "replicates": [290.9170886297404, 316.99841500792496, 317.23388017936685, 328.6943142877125, 336.9831508424578, 5462.825492519108, 6311.968440157799, 6480.449161821245, 6552.246491653461, 6585.637789921552, 5623.240862483563, 5673.886522269562, 6384.457321127709, 6410.134631824702, 6421.454176395012, 4483.4171557697455, 4568.794404251817, 4577.359169716243, 4745.999999999992, 4788.880277993043, 4608.5852273295395, 4676.228422310314, 4686.90626187476, 4730.290456431529, 4769.18923782956, 4652.371929789486, 4670.556297151765, 4684.461286951993, 4694.460137084227, 4699.459562150362, 4458.97770511147, 4556.179887620227, 4557.270836666117, 4559.840405585822, 4665.4168228971375, 3960.2673505401594, 3961.2473630010495, 3980.5820388859042, 3980.840766369342, 3985.720999530034, 5895.145203945447, 5953.464188223037, 6038.728257228435, 6043.005808083322, 6163.075538669235, 5429.321334833146, 5442.401335853053, 5448.972755136238, 5458.4541545845095, 5460.453954604508, 6037.064255040432, 6205.100260462253, 6510.121133646991, 6747.359000894907, 6802.693878775467, 4427.026054268056, 4427.048184640285, 4429.844955426544, 4430.26900561407, 4431.911361772779, 7087.255838136973, 7153.070100886904, 7165.140183178052, 7167.0, 7172.390346820474, 4360.934585981213, 4479.193745125908, 4487.192305385062, 4497.302918047708, 4508.008238187594, 4037.6877514807807, 4305.397244385788, 4571.9085618287445, 4574.313852922021, 4579.221532339444, 4385.736855788663, 4618.076384723069, 5410.729463526808, 5427.728613569306, 5429.837104886859, 6580.901286480706, 6811.625360605214, 6826.897596536056, 6834.760783372558, 6838.589684618939, 1518.3015812726048, 1581.0, 1591.0294720220656, 1592.1720705233213, 1594.609320716432, 988.2588058955783, 995.3679413572434, 999.8200323941614, 1000.4297550396204, 1006.3056491021172, 6292.993121100602, 6309.495240380758, 6320.683965801692, 6321.0, 6339.936600634027, 7050.5769653820935, 7054.435645148375, 7055.541389809646, 7071.010058591802, 7111.040009598742, 6066.939330606638, 6309.652969086653, 6309.779157729549, 6320.905186422207, 6322.36776322364, 3584.7849129052343, 3667.2298817248143, 3672.192117734094, 3672.5042119313553, 3794.4687743715904, 7481.027466429329, 7511.821571744133, 7519.0225270715555, 7520.586367749826, 7521.323080922743, 7114.826053701081, 7399.038125043709, 7403.259674032553, 7415.59214243211, 7432.442566807511, 7457.813554661177, 7492.400607951351, 7548.962255188799, 7554.395648348119, 7557.790753479417, 7184.784456466315, 7198.6400679964745, 7200.135983681992, 7211.8557628848175, 7215.67529461165, 6832.214295355899, 7078.539894906815, 7099.716011359487, 7101.467389945671, 7108.395786358217, 7522.548647081193, 7524.05949256343, 7526.9300942241325, 7534.397248220239, 7534.623268836426, 3823.827927743314, 4513.119941611486, 4540.545945405565, 4567.2920697291975, 4572.771361431848, 6306.46395056407, 6451.774162909032, 7125.287471252833, 7135.929610558458, 7171.569705817667, 5642.266505354278, 6843.520953533205, 6911.343422374866, 6912.827179320356, 6913.308669133046, 5534.7786088556, 5855.94144058554, 6881.311868813079, 6895.0, 6918.377346038881, 6545.345465453416, 6736.831579210559, 6736.966315168393, 6749.156355455568, 6764.492663050192, 6077.453029227391, 6884.931150688429, 6890.931090689029, 6906.689198985957, 6912.308769123048, 4891.853244402673, 5429.6199266051, 6776.457883369417, 6784.457243420613, 6785.626790526371], "unit": "score", "name": "prototype.html", "value": 4938.6749433074465}, {"lowerIsBetter": false, "replicates": [682.9897551536726, 695.110258868648, 704.1972151747009, 754.5702836865291, 789.7591234673422, 14630.049046811962, 15399.384024639015, 15528.53414397567, 15529.378824847021, 15548.300326485307, 14167.858321416783, 14233.359498822552, 14252.857471425283, 14255.501057462965, 14271.0, 695.6834640238704, 706.466617703633, 709.0781983421557, 854.1799872122754, 867.8611422172454, 792.8810678398229, 820.979475513111, 852.5055467828645, 873.76845136039, 879.0857508191473, 915.6749353979342, 919.3518569408584, 919.4621146629197, 920.9585568649393, 921.0927236671873, 715.2525610736792, 734.9154847192588, 736.4255880413286, 893.0890491698431, 907.5689047702355, 670.0786418674322, 672.237010992527, 672.3948446398232, 672.9831754206135, 674.8717743628695, 14813.0, 14934.850651493454, 14935.103893766409, 14937.850621493862, 14954.925225373912, 12358.196717213352, 12496.500139994389, 12680.936595316964, 12973.610791676265, 13190.340482975813, 10257.230707696952, 10485.475726213659, 11091.889081109166, 11187.216894817366, 11937.641870743892, 3512.7365447591533, 3561.0, 3564.8752293669854, 3589.0668426209113, 3638.2359704462096, 73156.1710957225, 73554.63222683906, 73928.15179620552, 76023.61988190023, 76388.23611763866, 9667.371620844622, 9690.224782017422, 9747.658831940847, 9782.0, 9960.501974901226, 21752.0, 21928.671069933964, 21955.451113722283, 22031.118755249612, 22133.0, 7512.32389084985, 7626.046744156981, 7779.416543759241, 7820.648070836826, 7930.246626570467, 4018.678505719535, 4083.6528895044253, 4085.1829634073306, 4098.508179018537, 4103.97948010258, 3603.4955106285142, 3664.413693809031, 3666.6699997000396, 3668.3763760160305, 3676.356637588411, 694.3438450664074, 721.815936936078, 722.1045903080247, 729.5112274775913, 732.7472022152349, 506.1572481817806, 553.4661188312573, 555.3446932619547, 585.833037584295, 635.8537536366662, 7167.534110282815, 8312.958435207785, 8544.658213671508, 8568.957155214184, 8667.869981950276, 503.41100911933125, 571.5170680774738, 582.6271186440681, 583.8102616649605, 587.9911801322984, 3937.125153910308, 3992.7604343739467, 4150.750954942713, 4162.458880345535, 4295.763732994716, 85581.57209213915, 86607.0, 90628.0, 90630.0, 90689.54655226681, 66309.0, 70715.0, 75756.62121689356, 75910.62044689852, 77004.61497692476, 67435.66282168558, 67550.64898701999, 68538.65730671315, 68640.65679671669, 69743.3025669757, 6911.75808846688, 8709.346798989975, 8713.564321784012, 8807.212898453727, 8913.930328360639, 45912.31131532963, 46129.538704612525, 47317.76341118272, 47921.76039119782, 48176.5182348172, 60568.39431605628, 64470.0, 66467.0, 67133.0, 67192.32807671861, 9845.655402060893, 10213.489325533843, 10942.17933654963, 10959.83560246581, 11316.49075791575, 11742.58900938463, 12026.879731202926, 12331.383430828602, 12645.304508252135, 12666.809997850223, 10930.125589952944, 11206.495707693337, 11309.773804524028, 11315.886841131813, 11869.40652967331, 9461.668841590512, 11429.142814288794, 11460.82808757886, 11611.825822612836, 12284.570040048555, 6726.737515973711, 10567.313124646873, 10988.560457581607, 11031.83452248233, 11091.889081109408, 9129.497877616795, 9487.66793162236, 9514.429134251966, 9639.759006024906, 9645.159047798821, 8358.331333493428, 9456.810863782548, 9720.279720279721, 10035.548400321857, 10092.949535252277], "unit": "score", "name": "yui.html", "value": 6805.033335067278}], "name": "dromaeo_css", "value": 7399.832308040765}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 110.0, 111.0, 111.0, 117.0, 109.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [181.0, 160.0, 166.0, 156.0, 121.0, 142.0, 140.0, 120.0, 160.0, 112.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [186.0, 182.0, 183.0, 185.0, 185.0, 183.0, 183.0, 180.0, 180.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.0}, {"lowerIsBetter": true, "replicates": [79.0, 71.0, 84.0, 76.0, 57.0, 57.0, 57.0, 75.0, 74.0, 61.0], "unit": "score", "name": "audio-fft", "value": 69.1}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 129.0, 83.0, 115.0, 122.0, 129.0, 75.0, 77.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 102.7}, {"lowerIsBetter": true, "replicates": [117.0, 93.0, 72.0, 137.0, 133.0, 94.0, 85.0, 92.0, 83.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 101.0, 106.0, 93.0, 93.0, 92.0, 92.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 94.9}, {"lowerIsBetter": true, "replicates": [86.0, 93.0, 122.0, 84.0, 84.0, 86.0, 87.0, 85.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 89.9}, {"lowerIsBetter": true, "replicates": [55.0, 53.0, 53.0, 52.0, 52.0, 53.0, 54.0, 64.0, 52.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [64.0, 69.0, 66.0, 75.0, 70.0, 66.0, 66.0, 66.0, 65.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 83.0, 81.0, 82.0, 81.0, 82.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 125.0, 119.0, 119.0, 122.0, 123.0, 123.0, 135.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [137.0, 105.0, 161.0, 176.0, 178.0, 149.0, 138.0, 166.0, 132.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 74.0, 97.0, 98.0, 100.0, 70.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.2}], "name": "kraken", "value": 1448.7}]} 04:52:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1448.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7399.83"}}} 04:52:38 INFO - Return code: 0 04:52:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:52:38 INFO - # TBPL SUCCESS # 04:52:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:38 INFO - 2016-02-06 04:52:38.944 screenresolution[1735:16696] starting screenresolution argv=screenresolution get 04:52:38 INFO - 2016-02-06 04:52:38.947 screenresolution[1735:16696] Display 0: 1600x1200x32@60 04:52:38 INFO - 2016-02-06 04:52:38.952 screenresolution[1736:16699] starting screenresolution argv=screenresolution list 04:52:38 INFO - Available Modes on Display 0 04:52:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:39 INFO - Intel Iris: 04:52:39 INFO - Chipset Model: Intel Iris 04:52:39 INFO - Type: GPU 04:52:39 INFO - Bus: Built-In 04:52:39 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:39 INFO - Vendor: Intel (0x8086) 04:52:39 INFO - Device ID: 0x0a2e 04:52:39 INFO - Revision ID: 0x0009 04:52:39 INFO - Displays: 04:52:39 INFO - Display: 04:52:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:39 INFO - Display Serial Number: 1600x1200 60 04:52:39 INFO - Main Display: Yes 04:52:39 INFO - Mirror: Off 04:52:39 INFO - Online: Yes 04:52:39 INFO - Rotation: Supported 04:52:39 INFO - Return code: 0 04:52:39 INFO - Running post-action listener: _resource_record_post_action 04:52:39 INFO - Running post-run listener: _resource_record_post_run 04:52:40 INFO - Total resource usage - Wall time: 1207s; CPU: 52.0%; Read bytes: 34098688; Write bytes: 709476352; Read time: 358; Write time: 2057 04:52:40 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404648448; Write bytes: 406984704; Read time: 30551; Write time: 840 04:52:40 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32312832; Write bytes: 301643776; Read time: 339; Write time: 1216 04:52:40 INFO - Running post-run listener: _upload_blobber_files 04:52:40 INFO - Blob upload gear active. 04:52:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:52:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:52:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:41 INFO - (blobuploader) - INFO - Done attempting. 04:52:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:52:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:42 INFO - (blobuploader) - INFO - Done attempting. 04:52:42 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:42 INFO - Return code: 0 04:52:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0806a62262ede181bfcae06df5d49844973c7e3d4ef6501b80511994f9be2207124a01f90f2e53ee83a4175d43249f3d0174fefd8b296034d1850ee72427e5e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53524a47ee6cae589f38b71e8d760acb21f81d8068ef610a11ad0688395941c486f91b7bc7e8955405e77ec924dc33f1f7e678b021deae8cd25511821f90029b"} 04:52:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:42 INFO - Contents: 04:52:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0806a62262ede181bfcae06df5d49844973c7e3d4ef6501b80511994f9be2207124a01f90f2e53ee83a4175d43249f3d0174fefd8b296034d1850ee72427e5e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53524a47ee6cae589f38b71e8d760acb21f81d8068ef610a11ad0688395941c486f91b7bc7e8955405e77ec924dc33f1f7e678b021deae8cd25511821f90029b"} 04:52:42 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:42 INFO - Copying logs to upload dir... 04:52:42 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.720040 ========= master_lag: 4.58 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-06 04:52:46.946846) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 04:52:46.950839) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0806a62262ede181bfcae06df5d49844973c7e3d4ef6501b80511994f9be2207124a01f90f2e53ee83a4175d43249f3d0174fefd8b296034d1850ee72427e5e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53524a47ee6cae589f38b71e8d760acb21f81d8068ef610a11ad0688395941c486f91b7bc7e8955405e77ec924dc33f1f7e678b021deae8cd25511821f90029b"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011156 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0806a62262ede181bfcae06df5d49844973c7e3d4ef6501b80511994f9be2207124a01f90f2e53ee83a4175d43249f3d0174fefd8b296034d1850ee72427e5e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53524a47ee6cae589f38b71e8d760acb21f81d8068ef610a11ad0688395941c486f91b7bc7e8955405e77ec924dc33f1f7e678b021deae8cd25511821f90029b"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 04:52:47.016819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:52:47.017197) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8RNxLFiRn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.oqt8AusVmR/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005247 ========= master_lag: 0.25 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:52:47.274924) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 04:52:47.275300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 04:52:47.277300) ========= ========= Total master_lag: 5.14 =========