builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0173 starttime: 1459626532.66 results: success (0) buildid: 20160402110310 builduid: aaa2080f7d6849ceb6fb73b21266223e revision: 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 12:48:52.658956) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 12:48:52.659416) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 12:48:52.659823) ========= 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.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.005645 basedir: '/builds/slave/test' ========= master_lag: 0.66 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 12:48:53.330230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 43 secs) (at 2016-04-02 12:48:53.330587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 43 secs) (at 2016-04-02 12:49:37.194607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 21 secs) (at 2016-04-02 12:49:37.194860) ========= 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.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.006067 ========= master_lag: 21.84 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 21 secs) (at 2016-04-02 12:49:59.040179) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 12:49:59.040482) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 12:49:59.040831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-04-02 12:49:59.041134) ========= 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.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-04-02 12:50:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.6M=0s 2016-04-02 12:50:00 (28.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.536033 ========= master_lag: 8.83 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-04-02 12:50:08.408823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-02 12:50:08.409180) ========= 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.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.026804 ========= master_lag: 1.92 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-02 12:50:10.360223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-02 12:50:10.360535) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 --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 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-04-02 12:50:10,688 truncating revision to first 12 chars 2016-04-02 12:50:10,688 Setting DEBUG logging. 2016-04-02 12:50:10,688 attempt 1/10 2016-04-02 12:50:10,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1f8433e85420?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-02 12:50:11,401 unpacking tar archive at: fx-team-1f8433e85420/testing/mozharness/ program finished with exit code 0 elapsedTime=0.962092 ========= master_lag: 6.78 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-02 12:50:18.100053) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 12:50:18.100414) ========= echo 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1f8433e85420fc2156ac0dbd68186cef5cf1ebe8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 program finished with exit code 0 elapsedTime=0.005702 script_repo_revision: '1f8433e85420fc2156ac0dbd68186cef5cf1ebe8' ========= master_lag: 0.61 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 12:50:18.719589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-04-02 12:50:18.719971) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-04-02 12:50:22.619304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-02 12:50:22.619622) ========= /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.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:50:23 INFO - MultiFileLogger online at 20160402 12:50:23 in /builds/slave/test 12:50:23 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 12:50:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:23 INFO - {'append_to_log': False, 12:50:23 INFO - 'base_work_dir': '/builds/slave/test', 12:50:23 INFO - 'blob_upload_branch': 'Fx-Team', 12:50:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:23 INFO - 'branch': 'Fx-Team', 12:50:23 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:23 INFO - 'config_files': ('talos/mac_config.py',), 12:50:23 INFO - 'default_actions': ('clobber', 12:50:23 INFO - 'read-buildbot-config', 12:50:23 INFO - 'download-and-extract', 12:50:23 INFO - 'populate-webroot', 12:50:23 INFO - 'create-virtualenv', 12:50:23 INFO - 'install', 12:50:23 INFO - 'run-tests'), 12:50:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:23 INFO - 'download_minidump_stackwalk': True, 12:50:23 INFO - 'download_symbols': 'ondemand', 12:50:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:50:23 INFO - 'tooltool.py': '/tools/tooltool.py', 12:50:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:50:23 INFO - '/tools/misc-python/virtualenv.py')}, 12:50:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:23 INFO - 'installer_path': 'installer.exe', 12:50:23 INFO - 'log_level': 'info', 12:50:23 INFO - 'log_name': 'talos', 12:50:23 INFO - 'log_to_console': True, 12:50:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:50:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:50:23 INFO - 'opt_config_files': (), 12:50:23 INFO - 'pip_index': False, 12:50:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:50:23 INFO - 'cmd': ('bash', 12:50:23 INFO - '-c', 12:50:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:50:23 INFO - 'enabled': True, 12:50:23 INFO - 'halt_on_failure': False, 12:50:23 INFO - 'name': 'check_screen_resolution'},), 12:50:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:50:23 INFO - 'cmd': ('bash', 12:50:23 INFO - '-c', 12:50:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:50:23 INFO - 'enabled': True, 12:50:23 INFO - 'halt_on_failure': False, 12:50:23 INFO - 'name': 'check_screen_resolution'},), 12:50:23 INFO - 'run_cmd_checks_enabled': True, 12:50:23 INFO - 'sps_profile': False, 12:50:23 INFO - 'sps_profile_interval': 0, 12:50:23 INFO - 'suite': 'dromaeojs', 12:50:23 INFO - 'system_bits': '32', 12:50:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:23 INFO - 'title': 't-yosemite-r7-0173', 12:50:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:23 INFO - 'use_talos_json': True, 12:50:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:23 INFO - 'work_dir': 'build'} 12:50:23 INFO - ##### 12:50:23 INFO - ##### Running clobber step. 12:50:23 INFO - ##### 12:50:23 INFO - Running pre-action listener: _resource_record_pre_action 12:50:23 INFO - Running main action method: clobber 12:50:23 INFO - rmtree: /builds/slave/test/build 12:50:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:24 INFO - Running post-action listener: _resource_record_post_action 12:50:24 INFO - ##### 12:50:24 INFO - ##### Running read-buildbot-config step. 12:50:24 INFO - ##### 12:50:24 INFO - Running pre-action listener: _resource_record_pre_action 12:50:24 INFO - Running main action method: read_buildbot_config 12:50:24 INFO - Using buildbot properties: 12:50:24 INFO - { 12:50:24 INFO - "project": "", 12:50:24 INFO - "product": "firefox", 12:50:24 INFO - "script_repo_revision": "production", 12:50:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:50:24 INFO - "repository": "", 12:50:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:50:24 INFO - "buildid": "20160402110310", 12:50:24 INFO - "pgo_build": "False", 12:50:24 INFO - "basedir": "/builds/slave/test", 12:50:24 INFO - "buildnumber": 667, 12:50:24 INFO - "slavename": "t-yosemite-r7-0173", 12:50:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:50:24 INFO - "platform": "yosemite_r7", 12:50:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:50:24 INFO - "branch": "fx-team", 12:50:24 INFO - "repo_path": "integration/fx-team", 12:50:24 INFO - "revision": "1f8433e85420fc2156ac0dbd68186cef5cf1ebe8", 12:50:24 INFO - "stage_platform": "macosx64", 12:50:24 INFO - "builduid": "aaa2080f7d6849ceb6fb73b21266223e", 12:50:24 INFO - "slavebuilddir": "test" 12:50:24 INFO - } 12:50:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 12:50:24 INFO - Running post-action listener: _resource_record_post_action 12:50:24 INFO - ##### 12:50:24 INFO - ##### Running download-and-extract step. 12:50:24 INFO - ##### 12:50:24 INFO - Running pre-action listener: _resource_record_pre_action 12:50:24 INFO - Running main action method: download_and_extract 12:50:24 INFO - mkdir: /builds/slave/test/build/tests 12:50:24 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')]} 12:50:24 INFO - https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:50:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:50:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:50:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:50:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 12:50:25 INFO - Downloaded 1199 bytes. 12:50:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:50:25 INFO - Using the following test package requirements: 12:50:25 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:50:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:50:25 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 12:50:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:50:25 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 12:50:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:50:25 INFO - u'jsshell-mac.zip'], 12:50:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:50:25 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 12:50:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:50:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:50:25 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 12:50:25 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:50:25 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 12:50:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:50:25 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 12:50:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:50:25 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 12:50:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:50:25 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')]} 12:50:25 INFO - https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:50:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:50:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:50:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:50:27 INFO - Downloaded 17959990 bytes. 12:50:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:50:30 INFO - Return code: 0 12:50:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:50:30 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')]} 12:50:30 INFO - https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:50:31 INFO - Downloaded 17959990 bytes. 12:50:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:50:35 INFO - Return code: 0 12:50:35 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')]} 12:50:35 INFO - https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:50:36 INFO - Downloaded 10847584 bytes. 12:50:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:50:36 INFO - Return code: 0 12:50:36 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')]} 12:50:36 INFO - https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 12:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 12:50:40 INFO - Downloaded 111315029 bytes. 12:50:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:50:40 INFO - mkdir: /builds/slave/test/properties 12:50:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:40 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:40 INFO - Contents: 12:50:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:50:42 INFO - Running post-action listener: _resource_record_post_action 12:50:42 INFO - Running post-action listener: set_extra_try_arguments 12:50:42 INFO - ##### 12:50:42 INFO - ##### Running populate-webroot step. 12:50:42 INFO - ##### 12:50:42 INFO - Running pre-action listener: _resource_record_pre_action 12:50:42 INFO - Running main action method: populate_webroot 12:50:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:42 INFO - '--tppagecycles', 12:50:42 INFO - '7'], 12:50:42 INFO - 'tests': ['tsvgm']}}, 12:50:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:50:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:50:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:42 INFO - 'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:42 INFO - 'tests': ['damp', 'tps']}, 12:50:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:42 INFO - 'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['damp', 'tps']}, 12:50:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:50:42 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['dromaeo_dom']}, 12:50:42 INFO - 'other': {'tests': ['a11yr', 12:50:42 INFO - 'ts_paint', 12:50:42 INFO - 'tpaint', 12:50:42 INFO - 'sessionrestore', 12:50:42 INFO - 'sessionrestore_no_auto_restore', 12:50:42 INFO - 'tabpaint']}, 12:50:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['a11yr', 12:50:42 INFO - 'ts_paint', 12:50:42 INFO - 'tpaint', 12:50:42 INFO - 'sessionrestore', 12:50:42 INFO - 'sessionrestore_no_auto_restore', 12:50:42 INFO - 'tabpaint']}, 12:50:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['a11yr', 12:50:42 INFO - 'ts_paint', 12:50:42 INFO - 'tpaint', 12:50:42 INFO - 'sessionrestore', 12:50:42 INFO - 'sessionrestore_no_auto_restore', 12:50:42 INFO - 'tabpaint']}, 12:50:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['a11yr', 12:50:42 INFO - 'ts_paint', 12:50:42 INFO - 'tpaint', 12:50:42 INFO - 'sessionrestore', 12:50:42 INFO - 'sessionrestore_no_auto_restore', 12:50:42 INFO - 'tabpaint']}, 12:50:42 INFO - 'other_l64': {'tests': ['a11yr', 12:50:42 INFO - 'ts_paint', 12:50:42 INFO - 'tpaint', 12:50:42 INFO - 'sessionrestore', 12:50:42 INFO - 'sessionrestore_no_auto_restore', 12:50:42 INFO - 'tabpaint']}, 12:50:42 INFO - 'other_nol64': {'tests': ['a11yr', 12:50:42 INFO - 'ts_paint', 12:50:42 INFO - 'tpaint', 12:50:42 INFO - 'sessionrestore', 12:50:42 INFO - 'sessionrestore_no_auto_restore', 12:50:42 INFO - 'tabpaint']}, 12:50:42 INFO - 'svgr': {'tests': ['tsvgx', 12:50:42 INFO - 'tsvgr_opacity', 12:50:42 INFO - 'tart', 12:50:42 INFO - 'tscrollx', 12:50:42 INFO - 'cart']}, 12:50:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['tsvgx', 12:50:42 INFO - 'tsvgr_opacity', 12:50:42 INFO - 'tart', 12:50:42 INFO - 'tscrollx', 12:50:42 INFO - 'cart']}, 12:50:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:42 INFO - 'tests': ['tp5o']}, 12:50:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:42 INFO - 'talos_options': ['--e10s'], 12:50:42 INFO - 'tests': ['tp5o']}, 12:50:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:42 INFO - 'talos_options': ['--xperf_path', 12:50:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:42 INFO - 'tests': ['tp5n']}, 12:50:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:42 INFO - 'talos_options': ['--e10s', 12:50:42 INFO - '--xperf_path', 12:50:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:42 INFO - 'tests': ['tp5n']}}, 12:50:42 INFO - 'talos.zip': {'path': '', 12:50:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:42 INFO - Running post-action listener: _resource_record_post_action 12:50:42 INFO - ##### 12:50:42 INFO - ##### Running create-virtualenv step. 12:50:42 INFO - ##### 12:50:42 INFO - Running pre-action listener: _resource_record_pre_action 12:50:42 INFO - Running main action method: create_virtualenv 12:50:42 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:42 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 12:50:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:42 INFO - Using real prefix '/tools/python27' 12:50:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:43 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:46 INFO - Installing pip.................done. 12:50:46 INFO - Return code: 0 12:50:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:46 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:50:46 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 12:50:46 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 12:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:46 INFO - 'HOME': '/Users/cltbld', 12:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:46 INFO - 'LOGNAME': 'cltbld', 12:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:46 INFO - 'MOZ_NO_REMOTE': '1', 12:50:46 INFO - 'NO_EM_RESTART': '1', 12:50:46 INFO - 'PAGER': '/bin/cat', 12:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:46 INFO - 'PWD': '/builds/slave/test', 12:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:46 INFO - 'SHELL': '/bin/bash', 12:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:50:46 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:46 INFO - 'USER': 'cltbld', 12:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:46 INFO - 'XPC_FLAGS': '0x0', 12:50:46 INFO - 'XPC_SERVICE_NAME': '0', 12:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:46 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 12:50:46 INFO - Cleaning up... 12:50:46 INFO - Return code: 0 12:50:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:46 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:50:46 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 12:50:46 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 12:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:46 INFO - 'HOME': '/Users/cltbld', 12:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:46 INFO - 'LOGNAME': 'cltbld', 12:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:46 INFO - 'MOZ_NO_REMOTE': '1', 12:50:46 INFO - 'NO_EM_RESTART': '1', 12:50:46 INFO - 'PAGER': '/bin/cat', 12:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:46 INFO - 'PWD': '/builds/slave/test', 12:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:46 INFO - 'SHELL': '/bin/bash', 12:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:50:46 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:46 INFO - 'USER': 'cltbld', 12:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:46 INFO - 'XPC_FLAGS': '0x0', 12:50:46 INFO - 'XPC_SERVICE_NAME': '0', 12:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:46 INFO - Downloading/unpacking psutil>=0.7.1 12:50:46 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 12:50:46 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 12:50:46 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 12:50:46 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 12:50:46 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 12:50:46 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 12:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:50 INFO - Installing collected packages: psutil 12:50:50 INFO - Running setup.py install for psutil 12:50:50 INFO - building 'psutil._psutil_osx' extension 12:50:50 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 12:50:51 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 12:50:51 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 12:50:51 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 12:50:51 INFO - building 'psutil._psutil_posix' extension 12:50:51 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 12:50:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:50:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:50:51 INFO - ^ 12:50:51 INFO - 1 warning generated. 12:50:51 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 12:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:51 INFO - Successfully installed psutil 12:50:51 INFO - Cleaning up... 12:50:51 INFO - Return code: 0 12:50:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:50:51 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')]} 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:51 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')]} 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:51 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:50:51 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 12:50:51 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 12:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:51 INFO - 'HOME': '/Users/cltbld', 12:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:51 INFO - 'LOGNAME': 'cltbld', 12:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:51 INFO - 'MOZ_NO_REMOTE': '1', 12:50:51 INFO - 'NO_EM_RESTART': '1', 12:50:51 INFO - 'PAGER': '/bin/cat', 12:50:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:51 INFO - 'PWD': '/builds/slave/test', 12:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:51 INFO - 'SHELL': '/bin/bash', 12:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:50:51 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:51 INFO - 'USER': 'cltbld', 12:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:51 INFO - 'XPC_FLAGS': '0x0', 12:50:51 INFO - 'XPC_SERVICE_NAME': '0', 12:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:50:51 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 12:50:51 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 12:50:51 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 12:50:51 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 12:50:51 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 12:50:51 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 12:50:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:50:54 INFO - Installing collected packages: mozsystemmonitor 12:50:54 INFO - Running setup.py install for mozsystemmonitor 12:50:54 INFO - Successfully installed mozsystemmonitor 12:50:54 INFO - Cleaning up... 12:50:54 INFO - Return code: 0 12:50:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:54 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:50:54 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 12:50:54 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 12:50:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:50:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:54 INFO - 'HOME': '/Users/cltbld', 12:50:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:54 INFO - 'LOGNAME': 'cltbld', 12:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:54 INFO - 'MOZ_NO_REMOTE': '1', 12:50:54 INFO - 'NO_EM_RESTART': '1', 12:50:54 INFO - 'PAGER': '/bin/cat', 12:50:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:54 INFO - 'PWD': '/builds/slave/test', 12:50:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:54 INFO - 'SHELL': '/bin/bash', 12:50:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:50:54 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:50:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:54 INFO - 'USER': 'cltbld', 12:50:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:54 INFO - 'XPC_FLAGS': '0x0', 12:50:54 INFO - 'XPC_SERVICE_NAME': '0', 12:50:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:50:55 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 12:50:55 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 12:50:55 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 12:50:55 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 12:50:55 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 12:50:55 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 12:50:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:50:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:50:57 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 12:50:57 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 12:50:57 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 12:50:57 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 12:50:57 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 12:50:57 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 12:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:50:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:50:58 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 12:50:58 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 12:50:58 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 12:50:58 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 12:50:58 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 12:50:58 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 12:50:59 INFO - Downloading docopt-0.6.1.tar.gz 12:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:50:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:50:59 INFO - Running setup.py install for blobuploader 12:50:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:50:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:50:59 INFO - Running setup.py install for requests 12:50:59 INFO - Running setup.py install for docopt 12:51:00 INFO - Successfully installed blobuploader requests docopt 12:51:00 INFO - Cleaning up... 12:51:00 INFO - Return code: 0 12:51:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:00 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')]} 12:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:00 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')]} 12:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:00 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:51:00 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 12:51:00 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 12:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:00 INFO - 'HOME': '/Users/cltbld', 12:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:00 INFO - 'LOGNAME': 'cltbld', 12:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:00 INFO - 'MOZ_NO_REMOTE': '1', 12:51:00 INFO - 'NO_EM_RESTART': '1', 12:51:00 INFO - 'PAGER': '/bin/cat', 12:51:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:00 INFO - 'PWD': '/builds/slave/test', 12:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:00 INFO - 'SHELL': '/bin/bash', 12:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:51:00 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:00 INFO - 'USER': 'cltbld', 12:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:00 INFO - 'XPC_FLAGS': '0x0', 12:51:00 INFO - 'XPC_SERVICE_NAME': '0', 12:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-6zVK06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-7j_dVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-MPKTYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-vEI9cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-QAEwD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-QQAMg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-yl47vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-x3pO7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-HsEOBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-f8I1oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-6wGKln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-_c69EZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-zREUOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Nw0hfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-AGQj12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-QbgGGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:02 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-tz7yHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:02 INFO - Running setup.py install for manifestparser 12:51:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:51:02 INFO - Running setup.py install for mozcrash 12:51:02 INFO - Running setup.py install for mozdebug 12:51:02 INFO - Running setup.py install for mozdevice 12:51:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:51:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:51:02 INFO - Running setup.py install for mozfile 12:51:02 INFO - Running setup.py install for mozhttpd 12:51:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:03 INFO - Running setup.py install for mozinfo 12:51:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:03 INFO - Running setup.py install for mozInstall 12:51:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:03 INFO - Running setup.py install for mozleak 12:51:03 INFO - Running setup.py install for mozlog 12:51:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:03 INFO - Running setup.py install for moznetwork 12:51:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:03 INFO - Running setup.py install for mozprocess 12:51:03 INFO - Running setup.py install for mozprofile 12:51:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:04 INFO - Running setup.py install for mozrunner 12:51:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:04 INFO - Running setup.py install for mozscreenshot 12:51:04 INFO - Running setup.py install for moztest 12:51:04 INFO - Running setup.py install for mozversion 12:51:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:04 INFO - Cleaning up... 12:51:04 INFO - Return code: 0 12:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:04 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')]} 12:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:04 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')]} 12:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:04 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:51:04 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 12:51:04 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 12:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:04 INFO - 'HOME': '/Users/cltbld', 12:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:04 INFO - 'LOGNAME': 'cltbld', 12:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:04 INFO - 'MOZ_NO_REMOTE': '1', 12:51:04 INFO - 'NO_EM_RESTART': '1', 12:51:04 INFO - 'PAGER': '/bin/cat', 12:51:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:04 INFO - 'PWD': '/builds/slave/test', 12:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:04 INFO - 'SHELL': '/bin/bash', 12:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:51:04 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:04 INFO - 'USER': 'cltbld', 12:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:04 INFO - 'XPC_FLAGS': '0x0', 12:51:04 INFO - 'XPC_SERVICE_NAME': '0', 12:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-H1gime-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:05 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)) 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Vy9THC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-3XdBRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:05 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)) 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-pldfRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:05 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)) 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-VPx64U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:05 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)) 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-X0JdZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:05 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)) 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-VCrRZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:05 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)) 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-1jcltf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:05 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)) 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:05 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-uDI9qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:06 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)) 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-6hkyYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:06 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)) 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-R8YqES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:06 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)) 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-9cBYQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:06 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)) 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-m5IN9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:06 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)) 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-n49BMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:06 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)) 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-pQQHWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:06 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)) 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-p5owQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:06 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)) 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:06 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-oHoV6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:06 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)) 12:51:06 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:51:06 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:51:06 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)) 12:51:06 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)) 12:51:06 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)) 12:51:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:10 INFO - Downloading blessings-1.6.tar.gz 12:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:10 INFO - Installing collected packages: blessings 12:51:10 INFO - Running setup.py install for blessings 12:51:10 INFO - Successfully installed blessings 12:51:10 INFO - Cleaning up... 12:51:10 INFO - Return code: 0 12:51:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:10 INFO - Reading from file tmpfile_stdout 12:51:10 INFO - Current package versions: 12:51:10 INFO - blessings == 1.6 12:51:10 INFO - blobuploader == 1.2.4 12:51:10 INFO - docopt == 0.6.1 12:51:10 INFO - manifestparser == 1.1 12:51:10 INFO - mozInstall == 1.12 12:51:10 INFO - mozcrash == 0.17 12:51:10 INFO - mozdebug == 0.1 12:51:10 INFO - mozdevice == 0.48 12:51:10 INFO - mozfile == 1.2 12:51:10 INFO - mozhttpd == 0.7 12:51:10 INFO - mozinfo == 0.9 12:51:10 INFO - mozleak == 0.1 12:51:10 INFO - mozlog == 3.1 12:51:10 INFO - moznetwork == 0.27 12:51:10 INFO - mozprocess == 0.22 12:51:10 INFO - mozprofile == 0.28 12:51:10 INFO - mozrunner == 6.11 12:51:10 INFO - mozscreenshot == 0.1 12:51:10 INFO - mozsystemmonitor == 0.0 12:51:10 INFO - moztest == 0.7 12:51:10 INFO - mozversion == 1.4 12:51:10 INFO - psutil == 3.1.1 12:51:10 INFO - requests == 1.2.3 12:51:10 INFO - wsgiref == 0.1.2 12:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:10 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')]} 12:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:10 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')]} 12:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:10 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:51:10 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 12:51:10 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 12:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:10 INFO - 'HOME': '/Users/cltbld', 12:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:10 INFO - 'LOGNAME': 'cltbld', 12:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:10 INFO - 'MOZ_NO_REMOTE': '1', 12:51:10 INFO - 'NO_EM_RESTART': '1', 12:51:10 INFO - 'PAGER': '/bin/cat', 12:51:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:10 INFO - 'PWD': '/builds/slave/test', 12:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:10 INFO - 'SHELL': '/bin/bash', 12:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:51:10 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:10 INFO - 'USER': 'cltbld', 12:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:10 INFO - 'XPC_FLAGS': '0x0', 12:51:10 INFO - 'XPC_SERVICE_NAME': '0', 12:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 INFO - Cleaning up... 12:51:11 INFO - Return code: 0 12:51:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:11 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')]} 12:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:11 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')]} 12:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:11 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:51:11 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 12:51:11 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 12:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:11 INFO - 'HOME': '/Users/cltbld', 12:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:11 INFO - 'LOGNAME': 'cltbld', 12:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:11 INFO - 'MOZ_NO_REMOTE': '1', 12:51:11 INFO - 'NO_EM_RESTART': '1', 12:51:11 INFO - 'PAGER': '/bin/cat', 12:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:11 INFO - 'PWD': '/builds/slave/test', 12:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:11 INFO - 'SHELL': '/bin/bash', 12:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:51:11 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:11 INFO - 'USER': 'cltbld', 12:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:11 INFO - 'XPC_FLAGS': '0x0', 12:51:11 INFO - 'XPC_SERVICE_NAME': '0', 12:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:11 INFO - Downloading/unpacking jsonschema 12:51:11 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 12:51:11 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 12:51:11 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 12:51:11 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 12:51:11 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 12:51:11 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 12:51:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:14 INFO - Downloading/unpacking functools32 (from jsonschema) 12:51:14 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 12:51:14 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 12:51:14 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 12:51:14 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 12:51:14 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 12:51:14 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 12:51:14 INFO - Downloading functools32-3.2.3-2.tar.gz 12:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:51:14 INFO - warning: no files found matching '*.txt' 12:51:14 INFO - no previously-included directories found matching 'build' 12:51:14 INFO - no previously-included directories found matching 'dist' 12:51:14 INFO - no previously-included directories found matching '.git*' 12:51:14 INFO - Installing collected packages: jsonschema, functools32 12:51:14 INFO - Running setup.py install for functools32 12:51:14 INFO - warning: no files found matching '*.txt' 12:51:14 INFO - no previously-included directories found matching 'build' 12:51:14 INFO - no previously-included directories found matching 'dist' 12:51:14 INFO - no previously-included directories found matching '.git*' 12:51:14 INFO - Successfully installed jsonschema functools32 12:51:14 INFO - Cleaning up... 12:51:14 INFO - Return code: 0 12:51:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:14 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 0x103627a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103637420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe516aa170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, '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.1XdopKfWvu/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.tFaPb027Ev/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 12:51:14 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 12:51:14 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 12:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:14 INFO - 'HOME': '/Users/cltbld', 12:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:14 INFO - 'LOGNAME': 'cltbld', 12:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:14 INFO - 'MOZ_NO_REMOTE': '1', 12:51:14 INFO - 'NO_EM_RESTART': '1', 12:51:14 INFO - 'PAGER': '/bin/cat', 12:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:14 INFO - 'PWD': '/builds/slave/test', 12:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:14 INFO - 'SHELL': '/bin/bash', 12:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:51:14 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:14 INFO - 'USER': 'cltbld', 12:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:14 INFO - 'XPC_FLAGS': '0x0', 12:51:14 INFO - 'XPC_SERVICE_NAME': '0', 12:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:15 INFO - Downloading/unpacking flake8 12:51:15 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 12:51:15 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 12:51:15 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 12:51:15 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 12:51:15 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 12:51:15 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 12:51:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:51:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:51:17 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 12:51:17 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 12:51:17 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 12:51:17 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 12:51:17 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 12:51:17 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 12:51:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:51:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:51:18 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 12:51:18 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 12:51:18 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 12:51:18 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 12:51:18 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 12:51:18 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 12:51:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:51:18 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 12:51:18 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 12:51:18 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 12:51:18 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 12:51:18 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 12:51:18 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 12:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:18 INFO - no previously-included directories found matching 'docs/_build' 12:51:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:51:19 INFO - Running setup.py install for pep8 12:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:19 INFO - no previously-included directories found matching 'docs/_build' 12:51:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:51:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:51:19 INFO - Cleaning up... 12:51:19 INFO - Return code: 0 12:51:19 INFO - Running post-action listener: _resource_record_post_action 12:51:19 INFO - Running post-action listener: _start_resource_monitoring 12:51:19 INFO - Starting resource monitoring. 12:51:19 INFO - ##### 12:51:19 INFO - ##### Running install step. 12:51:19 INFO - ##### 12:51:19 INFO - Running pre-action listener: _resource_record_pre_action 12:51:19 INFO - Running main action method: install 12:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:19 INFO - Reading from file tmpfile_stdout 12:51:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:19 INFO - Reading from file tmpfile_stdout 12:51:19 INFO - Output received: 12:51:19 INFO - Usage: mozinstall [options] installer 12:51:19 INFO - Options: 12:51:19 INFO - -h, --help show this help message and exit 12:51:19 INFO - -d DEST, --destination=DEST 12:51:19 INFO - Directory to install application into. [default: 12:51:19 INFO - "/builds/slave/test"] 12:51:19 INFO - --app=APP Application being installed. [default: firefox] 12:51:19 INFO - mkdir: /builds/slave/test/build/application 12:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:51:54 INFO - Reading from file tmpfile_stdout 12:51:54 INFO - Output received: 12:51:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:51:54 INFO - Running post-action listener: _resource_record_post_action 12:51:54 INFO - ##### 12:51:54 INFO - ##### Running run-tests step. 12:51:54 INFO - ##### 12:51:54 INFO - Running pre-action listener: _resource_record_pre_action 12:51:54 INFO - Running main action method: run_tests 12:51:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:51:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:51:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:51:54 INFO - 2016-04-02 12:51:54.105 screenresolution[1646:8099] starting screenresolution argv=screenresolution get 12:51:54 INFO - 2016-04-02 12:51:54.108 screenresolution[1646:8099] Display 0: 1600x1200x32@60 12:51:54 INFO - 2016-04-02 12:51:54.113 screenresolution[1647:8101] starting screenresolution argv=screenresolution list 12:51:54 INFO - Available Modes on Display 0 12:51:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:51:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:51:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:51:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:51:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:51:54 INFO - Intel Iris: 12:51:54 INFO - Chipset Model: Intel Iris 12:51:54 INFO - Type: GPU 12:51:54 INFO - Bus: Built-In 12:51:54 INFO - VRAM (Dynamic, Max): 1536 MB 12:51:54 INFO - Vendor: Intel (0x8086) 12:51:54 INFO - Device ID: 0x0a2e 12:51:54 INFO - Revision ID: 0x0009 12:51:54 INFO - Displays: 12:51:54 INFO - Display: 12:51:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:51:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:51:54 INFO - Display Serial Number: 1600x1200 60 12:51:54 INFO - Main Display: Yes 12:51:54 INFO - Mirror: Off 12:51:54 INFO - Online: Yes 12:51:54 INFO - Rotation: Supported 12:51:54 INFO - Return code: 0 12:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:54 INFO - Python 2.7.3 12:51:54 INFO - Return code: 0 12:51:54 INFO - grabbing minidump binary from tooltool 12:51: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')]} 12:51:54 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 0x1034c6e00>, '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 0x1032efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:54 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 12:51:54 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 12:51:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:54 INFO - Return code: 0 12:51:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:51:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:51:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:51:55 INFO - Return code: 0 12:51:55 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', 'https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 12:51:55 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 https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0173 --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 12:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1XdopKfWvu/Render', 12:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:55 INFO - 'HOME': '/Users/cltbld', 12:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:55 INFO - 'LOGNAME': 'cltbld', 12:51:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:55 INFO - 'MOZ_NO_REMOTE': '1', 12:51:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:55 INFO - 'NO_EM_RESTART': '1', 12:51:55 INFO - 'PAGER': '/bin/cat', 12:51:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:55 INFO - 'PWD': '/builds/slave/test', 12:51:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:55 INFO - 'SHELL': '/bin/bash', 12:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tFaPb027Ev/Listeners', 12:51:55 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 12:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:55 INFO - 'USER': 'cltbld', 12:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:55 INFO - 'XPC_FLAGS': '0x0', 12:51:55 INFO - 'XPC_SERVICE_NAME': '0', 12:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:55 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', 'https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 12:51:55 INFO - mozversion application_buildid: 20160402110310 12:51:55 INFO - mozversion application_changeset: 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 12:51:55 INFO - mozversion application_display_name: Nightly 12:51:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:55 INFO - mozversion application_name: Firefox 12:51:55 INFO - mozversion application_remotingname: firefox 12:51:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:51:55 INFO - mozversion application_vendor: Mozilla 12:51:55 INFO - mozversion application_version: 48.0a1 12:51:55 INFO - mozversion platform_buildid: 20160402110310 12:51:55 INFO - mozversion platform_changeset: 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 12:51:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:51:55 INFO - mozversion platform_version: 48.0a1 12:51:55 INFO - using testdate: 1459626715 12:51:55 INFO - actual date: 1459626715 12:51:55 INFO - starting webserver on 'localhost:49275' 12:51:55 INFO - SUITE-START | Running 2 tests 12:51:55 INFO - TEST-START | dromaeo_css 12:51:55 INFO - operating with platform_type : mac_ 12:51:55 INFO - Initialising browser for dromaeo_css test... 12:51:55 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpzZ2opJ/profile http://localhost:49275/getInfo.html) 12:51:58 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 12:51:58 INFO - PROCESS | 1665 | colorDepth:24 12:51:58 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 12:51:58 INFO - PROCESS | 1665 | __metrics 12:51:58 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:51:58 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:51:58 INFO - TEST-INFO | 1665: exit 0 12:51:58 INFO - Browser initialized. 12:51:58 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:58 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpzZ2opJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:10 INFO - PROCESS | 1668 | RSS: Main: 236302336 12:52:10 INFO - PROCESS | 1668 | 12:53:02 INFO - PROCESS | 1668 | 1459626782140 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] 12:55:12 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 12:55:13 INFO - PROCESS | 1668 | RSS: Main: 380354560 12:55:13 INFO - PROCESS | 1668 | 12:58:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 12:58:16 INFO - PROCESS | 1668 | RSS: Main: 362291200 12:58:16 INFO - PROCESS | 1668 | 13:01:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 13:01:19 INFO - PROCESS | 1668 | RSS: Main: 363802624 13:01:19 INFO - PROCESS | 1668 | 13:04:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 13:04:21 INFO - PROCESS | 1668 | RSS: Main: 326832128 13:04:21 INFO - PROCESS | 1668 | 13:07:25 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 13:07:25 INFO - PROCESS | 1668 | RSS: Main: 325181440 13:07:25 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 13:10:28 INFO - PROCESS | 1668 | RSS: Main: 373202944 13:10:28 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | __start_tp_report 13:10:28 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 13:10:28 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 13:10:28 INFO - PROCESS | 1668 | |i|pagename|runs| 13:10:28 INFO - PROCESS | 1668 | |0;dojo.html;2882.0921409755924;3448.49996750471;3454.7236221102316;3488.2151515908918;3513.0339156731898;5579.9163012554845;5637.8590535236635;5638;5660.320761508615;5675.8581035474135;5614.466625670555;5638.267025286707;5694.430556944303;5707.286589176353;5772.624779389337;5061.5950723942;5063.493650634926;5086.084504789136;5089;5222.32109825724;5224;5226.634135610509;5242.501962313593;5278.762455689484;5288.65623734456;5051.9494805051845;5129.666571672829;5151.6908985461;5161.509656582619;5188.558972487324;5108.463611320795;5150.819721309774;5156.690598564098;5158.793648254065;5167.509086636764;5067.594592432597;5104.948950510522;5110.131277682765;5117.667351622133;5125.820596279113;5550.0564903966015;5554.111342185231;5571.164325351189;5578.414266501999;5594.832155035356;5660.915086273709;6097.231802777189;6204.565680402374;6205.441510264098;6230.127782110463;5057.0897238497055;6260.655663938482;6269.341719119518;6274.780382686584;6285.9057114143325;5726.570507211975;5735.627184233053;5748.128371546265;5757.222774925373;5810.4770570648425;6186.505079593621;6263.060540918898;6311.368863113744;6339.175907132043;6359.427651511293;6046.606970546901;6073.271207455134;6093.969530152321;6095.481884039907;6096.573239873166;5654.7276862706385;5892.616979896293;6083;6217.937820621826;6238.438540531283;6095.512359011268;6102.420270074336;6123.326434092246;6154.876902461926;6163.599366041282;6178.938210617836;6181.196444462191;6199.628022318675;6206.813795586139;6217.160683307786;4760.309755085494;4880.1215781159735;4880.804767809319;4882.36529251195;4896.143174944442;4324.200022995693;4339.284018137035;4367.606915377632;4412.6690498212765;4421;5599.272094627754;5601.5238704710555;5619.269494965628;5620.185073164368;5622.662640241599;6047.576669633171;6176.567640265228;6218.502519798405;6219.626822390671;6222.408871157323;5584.832455026356;5592;5673.035583950738;5695.145728140812;5713.457221563945;5319.0957537218765;5328;5332;5332.653377530448;5334.333208348957;6192.845178870564;6273.153124328249;6276.215473065867;6302.464290535264;6303.684815759286;6104.4591554472245;6127.234095738033;6127.769884593299;6133.05924499315;6141.179174348115;6243.531735119975;6249.50003999688;6299.401556852092;6309.3690630936535;6329.430351268408;6133.916185115316;6139.938600614116;6153.538484613761;6153.692315384303;6159.6612186330185;6220.066989951543;6223.0354295084335;6224.097505861534;6228.626282423069;6261.467775238973;5847.590668653153;5922.7927022554;5963.373845746134;6016.849578760391;6038.215032045806;5033.471485494117;5165.870853228699;5913.201717768046;6024.277086749618;6033.215681961317;5856.59003869725;5892.499137573354;5897.675627840338;5898.675572843363;5914;5885.205497257815;5912.260967379078;6012.549058820693;6089.665068421279;6114.510839132948;5707.7716891325545;5893.351731309467;5897.823065308047;5898;5924.763009479745 13:10:28 INFO - PROCESS | 1668 | |1;ext.html;462.9282461218512;571.3058633759983;572.5963195946855;632.1844820181964;642.1331202876117;30347;38630.22739545211;38998.415023774665;39008.80495597518;39022.024449388744;41817.16365672685;42194.7890260549;42222.52221172259;42251;42452;9362.531873406353;9606;9612.615495380176;9616.855747163798;9621.855672164887;7963.562004089773;9462.668806591771;9472.336936414455;9485.525723713821;9493.288003399739;9477;9633.421994680306;9643.758906027335;9647.469389183592;9658.565364558612;8553.230209281131;9393.953030234874;9560.61757529698;9623.326367154303;9629.662961796339;9551.808963820684;9571.569279382375;9578.6647467339;9587.760305992337;9688.564014619358;41191;41477.585224147675;41629.58370416288;41753.1649367011;41756.16487670229;3162.652108268089;3382.154461384654;3382.96617033829;3574.338747331726;3814.256220037094;28348.291292717848;29003.12990610285;29999.850000750073;30275.091747247618;30283.545746813816;2774.611554382388;2848.5299925512268;2852.3154442933755;2865.498537755905;2878.7409133177907;399406;474631;475657;475790.24209757807;478079;66851.66574167195;67494;67921;67942.66028669824;67979.3202067983;70717.93923091158;70901.64549177221;70977.64511177411;71121.6443917777;71128.64435677892;16540.586485337964;16734.24695888688;16751;16757.664846703243;16786.32854685799;12692.555760548337;12732.872671273353;12735.29955852437;12738.235705857678;12748.426320815586;18825.94608541187;21121.26075587347;21122.57754844925;21128.260510882046;21164.259250926145;6663.400293973566;7738.922610773933;7905.841883162419;7914.525128492309;7971.641276142587;934.6775362499926;984.9458279794537;1024.764304210021;1130.5534313945946;1134.4554613785429;28042.579361309596;28083.71916280811;28487.57268640972;28761.99333023334;28784.856075719486;1088.78768640116;1122.910167186623;1149.2816989381636;1168.7019809948579;1174.2015429507846;14429;14628.48800292006;14939.356670766207;15244.390224391122;15297.694046119237;505323;505520;509616;513234;513283;59429.40570594325;59477.40522594805;59542.70228648829;59660;59698.40301597015;1329.5612447892172;1387.7163623648084;1447.2835946206694;1448.246911605959;1486.724955883165;25205.11782087618;28333.291667708472;29115.7088429113;29133.834646613897;29184.562231566968;46161;46382;46653.53346466492;46726.299105514125;46739.53260467352;350339;353157;353539;353917;354281;28502.144935651133;32751.672483274862;33812.492812607336;33820.32359352848;33995.320093598486;41458.79270603628;42045.57954420416;42178;42216.78891605645;42575.574244257165;30223.395532088794;35457.82271088628;36830.63169368272;36832.895013149646;37436.43845342377;35824.567017319016;36003.63996360003;36298.455523166645;36496;36558.7204447843;30926.690733092382;33591.99224023283;35878.820605896806;36102.45846312255;36637.26725465422;30557.694423055484;31062.54243380334;31345.551989281616;31359;31402;20491.565590409125;23200.419989499722;23350.76649233486;23545.764542354358;24296.87851560731 13:10:28 INFO - PROCESS | 1668 | |2;jquery.html;356.8626078959601;361.0756463453559;363.890832750175;368.1312103435891;372.8639046747938;19190.94449805262;19406.02969851507;20907.686384704222;20916.686249706265;20917.372478825622;16749.581260468494;20222.786632802043;20622.381328560128;20911.895440522778;20921.849298288587;5692.231548740919;5868.09044598088;5893.675847828367;5904.1734157218025;5913.674747888865;4104.42538044674;4370.38814565961;6205.9069113963105;6502.577332473397;6513.283538810727;6180.876382472348;6440.291567927524;6451.903221451682;6454.354564543555;6458.192725909262;5677.829665110012;6198.605313804403;6232.439080482778;6333.176687030679;6449.097126402307;3673.577538583044;5035.823746168867;5561.749721262553;5561.77752889884;5569.721513924287;24169.637455438184;24691.38271543208;25575.74424255752;25949.870250648815;25967.610485842728;2337.883105844701;2373.8694371809715;2412.408959804859;2531.822772405914;2535.77178053976;12501.812472812915;13654.112482688593;13981.720365592733;14374.993750437474;14898.851011489854;1548.783170356151;1633.4527933142292;1706.6330738891197;1708.7436884467304;1719.243532845544;97601;99532.50233748858;100281.49859250657;100552;102326;9814.312998090065;9966.700998970042;10207.183425325957;10255.94872025635;10313.84529232062;12638.368081595883;12738.745225095447;12765;12776.552820651232;12790.808137877939;8100.513969161751;8345.040320363236;8359.623816928131;8456.619452124669;8478.321734261244;7537;7886.526808391515;8598.269147122439;8599.484030958163;8734.737957861274;5980.910286345708;5988;6016.398360164036;6020.397960203944;6040.516758659297;1530.2501774130596;1608.6460978584694;1635.4766474727974;1697.702901992171;1772.2113659421434;889.9510526921082;961.3847137831793;969.3214749675255;1001.234055947201;1015.2740790334946;19096.61806763857;19378;19732.60534789296;19766.60466790685;20248.392548223575;884.9690111020717;949.3639261694681;975.4829940131741;1020.2908978260186;1030.7474668706216;11077;11375.658730238107;11387.601433949772;11396.373199473943;11495.827562586568;552225;558559;566237.7009839203;566853;568281;101947.98052019384;103799.4810025945;104689;107218.92781072245;108201;989.1987490133015;1030.7577719236124;1043.9425831579183;1046.6022911293812;1047.1988928469727;17656;17782.733259001383;18126.184321705292;18464.07679615987;18499.167537460577;48765;49419;49872.75063624659;50500.49499505105;50996.74501627468;70035;70675;74068.25931740613;74700.62649686717;74741.87887181588;7507.099148102263;7522.586257755657;7668.808279792826;7761.456698031084;8114.594270286344;7574.545527268381;12031.939840300742;12078.75842483163;12283.938580307042;12429.564965226175;8374.623141958748;10084.949575252076;10420.895791041992;10607.575696972035;10731.40977246259;9288.303377246868;9793.951030244803;9863.112319891245;10247.38515689061;10707.357558546511;6547.672616369067;7561.924380756122;10862.293950893167;10873.728156796144;11250.943745281222;7647.502912310682;7837.843243135219;7878.290953814184;7962.283394494523;8044.678212871419;9149.359544831797;9313.627454901729;10799.784004320027;10839.187060970302;11170.218084733991 13:10:28 INFO - PROCESS | 1668 | |3;mootools.html;1445.681949971006;1593.1795125510362;1620.3437607768853;1901.5246188452886;2024.5242368043498;8004.679812807488;8631.525266110362;8741.169588889044;8779.868301975475;8781.253593444564;8480;8736.912630873689;8759.518226497556;8766.868496972551;8771.780705482366;2173.913043478267;2401.519696060786;2461.212412028152;2465.4329504214043;2506.348349429143;2481.962770558443;2489.2781093482868;2492.47657991821;2494.276659768674;2495.837770544918;2390.5935990881503;2447.2535876557645;2464.691913510811;2471.6416119662726;2471.789897858675;2432.3311089450367;2455.1218317986754;2467.3708204407762;2484.0312278211513;2493.3891196656755;2391.557561851063;2411.0114852910224;2414.6860908081835;2419.8669073200967;2421.225207933462;8767;8848.29213662912;8848.380613357067;8848.778780530474;8849.911500884973;5430.782768689248;5572.944270557283;5573.470520300565;5598.524125449342;5608.270924779753;3574.267275208576;3697.279030589036;3735.9813200933822;3758.981205093957;3765.058735316171;1046.7592453735608;1059.7403636109125;1062.3731998121145;1074.1675201718651;1077.6066735641514;12023.759524809542;12026.27842329463;12032.217905836093;12089.153759236857;12091.758164836741;4870.465803271958;4897.477798933552;4963.379577552806;4964.453910069889;5003.024410239968;10113.696589102192;10143.898561014295;10163.847542286872;10165.898341016644;10172.745681358025;5563.916541251884;5576.191452239484;5576.33084029919;5577.247071645357;5591.804286850022;4126.8761937141935;4437.378766972626;4558.931616025762;4571.994161284512;4787.904241915142;3701.1857391373856;3823.5220597425323;3899.161680238762;3965.147493288957;3976.363781794899;1312.7768279392526;1324.8675132486674;1325.4830616059744;1340.249460302234;1343.7178192579668;1282.435728279554;1284.7237843863427;1309.3911331230834;1342.3020029584757;1350.1359130156707;8089.635966381527;8106.837863242702;8277.710280140167;8280.130586288473;8285.875711864326;517.3171413733835;531.2456312036917;532.5792623827133;533.9759710813023;534.0413956947289;6187.84530386735;6250.062490626442;6311.211098612674;6317.147185129948;6321.65230912295;10616.363018218777;10857.51141198648;10863;10940.56237750497;10961.232713709964;10395.792084158275;10687.14502839771;10694.144468442506;10809.40548269837;10851.077658398966;8368.665253389918;8384.455010424303;8454.49273043607;8468.407211495136;8478.194571515696;7647.808804779925;7983.800404989922;7993.080795708335;8006.879896801669;8036.236557527026;9399.154076133182;9518.190953769008;9722.076402741728;9759.072888075621;9856.112949834549;9613.51932403391;9974.650887218913;10015.549300281358;10076.294659373774;10257.384556926609;7505.924940750522;7525.924740752742;7541.283578060075;7584.469087163846;7595.848083038198;8283.792905177419;8309.33525317961;8373.790655233424;8374.413791034813;8382.371322150984;6751.291114432914;7111.502194846311;7367.889481657672;7466.514676546007;7611.162772094955;7286.1985181631035;7324.194338622854;7373.8156546086775;7380.225076367119;7383.778486645409;7779.455438119504;7812.960935195288;7877;7878.803029924297;7892.723754668559;7004.719811207495;7100.538464999759;7172.748953786592;7178.497505174588;7184.784456466105;7100.822479438056;7157.928420715934;7174.174969878322;7176.892346614909;7180.3537681608905 13:10:28 INFO - PROCESS | 1668 | |4;prototype.html;323.89797213877625;328.25649902969775;330.373941381083;333.2102916088869;336.46334097115107;4979.7261150636705;6391.712372943217;6392.968035159824;6412.230532336121;6429.871402571957;5681.261436013323;6407.871842563146;6417.454516366103;6432.742690292394;6447.742090316394;4479.888002799924;4556.407667003285;4642.442906851183;4678.883027924295;4702.6002789762915;4747.691400059002;4748.453927798296;4757.524247575232;4760.880977975544;4768.47546769855;4659.906801863961;4661.44062712475;4674.158651442739;4692.108499385123;4705.411823522059;4502.144592527409;4530.365748795171;4655.790489427984;4672.486026537078;4707.646926480511;3317.286783341569;4028.738132021409;4039.939400908989;4044;4044.6157615026527;5999.010163323046;6016.879662406771;6020.096985452174;6088.786892458743;6122.540809439265;5523.061079616475;5528.9494995950645;5530.760042182922;5539.169124631298;5545.639533430314;6787.966060169717;6791.252962174157;6801.761938332184;6805.149356330458;6815.182178138605;4264.850730224458;4471.709338892994;4498.730076195438;4571.748553829538;4575.95424045762;7202.927970720278;7237.601931893743;7269.781906542759;7282.235365286621;7311.159216690043;4528.366028755977;4538.750368729686;4540.0011997360525;4541.909161816745;4550.681452298373;4601.907961840744;4614.7461889595725;4622.768861556909;4630.699004564693;4632.559906808848;5437.238786569884;5442.972785136049;5454.563634909197;5471.179323101566;5472.753726082336;6658.067870498134;6863.2793556676825;6917.273686262971;6920.930790692129;6932.306769323028;1565.6399028223573;1567.3260497985975;1583.319172755703;1591.5702760254667;1592.8486793754807;1007.4610083605236;1010.5907107621425;1026.235454586338;1032.5250384823066;1033.0702367868978;6207.410296021871;6317.5893566918;6407.807765767035;6555.115059467006;6563.7702680405955;5908.409159084057;7200.747973820891;7216.422686185093;7224.4581656375985;7235.421166306683;6187.84530386744;6518.087467754518;6523.11937888379;6526.216853977553;6530.151080359523;3271.329377477611;3827.6746476549247;3832.1952389998414;3834.616538346143;3838.1747924196434;7242.167150777623;7576.090869095744;7576.204498527575;7576.424015834643;7586.203448637924;7370.8894366584545;7384.889226661604;7393.48245622812;7414.036175297285;7428.777136685908;7478.9252107479315;7503.512271702322;7508.361789247975;7516;7560.810979725551;7170.892436613351;7175.784726458214;7187.496875218684;7193.568385896863;7204.351608355273;6759.493038022069;7027.367536921702;7045;7051.5063945523325;7063.57618542889;6069.362716914837;7491.138519070377;7528.284812942762;7532.924670753222;7540.886886696594;4480.036792089716;4535.3650488932235;4540.046590215959;4544;4559.521250268674;5788.334341550775;7071.7878463646175;7084.326988936043;7084.893726594209;7089.361957423856;6559.836004099745;6846.863062738817;6857.485688573477;6882.896756548756;6916.827079323057;6860.828479288058;6889.414399776075;6901.551399159039;6909.689063992032;6919.654017299014;6756.324367563205;6769.1876974763345;6772.288909664611;6773.017912402773;6773.221079575912;6880.793576192722;6900.758473453405;6916.273791251846;6919.792406227822;6930.44556435494;6499.090127382265;6522.934770652422;6629.972354285093;6676.365745254193;6787.898181527183 13:10:28 INFO - PROCESS | 1668 | |5;yui.html;589.7022003888036;738.2764890407401;748.4985060009793;755.516469459546;759.8176437654964;14748.705025899475;14984.475543355984;14995.100293982368;15001.249937503137;15029.924850375746;13729;13851.445942162301;13855.930720346409;13859.861401385982;13866;743.6690672650673;761.2045412543905;914.1041779056528;943.2406912435487;947.606743201574;934.3786382055924;951.8191543606728;954.0983770337;954.2556805691537;954.5275088831038;1002.0480543483683;1003.7289931718432;1004.9949750251238;1005.7535903703603;1009.0010889219693;786.909505406877;800.8158123631539;806.753940048285;957.683964291782;995.0845222395413;747.0997448075111;747.5962979990799;747.8878168274748;749.1123019222239;750.6734570461866;14488.985770996034;14538.200398978051;14552;14563.199024053672;14573;12156.878431215751;12333.136680432373;12418.192817466926;12571.434285457177;12639;9247.306452016126;9661.855072173852;9828.655997040069;9841.311108222428;10387.948060259725;3488.0930957950864;3501.369753444379;3521.8239088045493;3559.5728512578658;3760.793156376398;78744.42511149745;78881.60559197224;78889.21110788875;78906.81639775408;79298.60350698268;9212.953935230282;9330.673426430043;9532.475713835667;9600.615975360908;9770.658026969022;21653;21686.891565542388;21692.783072169394;21726.239581614886;21776.128954841945;7355.513136986434;7432.293932076444;7465.06686664167;7484.962575187089;7542.622868856645;4062.7765472899273;4092.01791570027;4115.506139263308;4120.876373708794;4231.936520952188;3536.823158842099;3567.3578755823683;3596.047047532406;3597.244578638515;3601.4957905893198;644.4007073421762;656.2387630348773;661.0678942690782;661.2858113237692;664.5149041199951;552.6656372894421;580.2688612348471;603.0200923499314;613.9324674285825;633.1705465839765;7465.85068298631;8142.226488483585;8247.628856701464;8281.792955176168;8331.6667333306;505.2875445621656;556.6910364747604;585.92382990211;593.6853467662146;639.6322114784018;3795.6394142556414;3823.388257878726;3837.3092843288478;3888.3389823730035;3940.0517410567873;90030;90179;91497.54251228701;91718.08281917228;91873.54063229641;77340.61329693315;77572.44855102866;78304;78394;78470;63695.681521593026;64022.6798866012;65086;65120.34879651238;65416.69166616641;7754.418418618513;8221.349321204452;8565.828683426422;8609.268212202032;8789.516576588348;46920.76539617417;47740.2838957409;48255.758721207574;48631.5136848627;52072.47927520828;64816;65170.69658606707;65489;65551;66151.66924165348;10690.839637405601;10709.892901070889;10846.511906964048;11111.83332250033;11488.425578720864;11952.701182470508;12041.819372709591;12174.75650487003;12216.633500994983;12399.814002790146;9540.33217674756;11231.26996745209;11427.200095993201;11476.4261786912;11593;9897.208223341971;11353.262037967506;11372.147088968526;11727.648170554898;11763.47064382122;10914.18143639246;11070.612528561462;11223.38271395081;11329.603463878724;11593.536258549564;9483.099105584959;9636.180924621485;9703.272254581076;9757.951210243904;10035.749106272402;8590.613422396133;8985.236254918405;9570.47362395075;9635.22918166559;9743.074407931235 13:10:28 INFO - PROCESS | 1668 | __end_tp_report 13:10:28 INFO - PROCESS | 1668 | __start_cc_report 13:10:28 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1371 13:10:28 INFO - PROCESS | 1668 | __end_cc_report 13:10:28 INFO - PROCESS | 1668 | __startTimestamp1459627828553__endTimestamp 13:10:28 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | ------- Summary: start ------- 13:10:28 INFO - PROCESS | 1668 | Number of tests: 6 13:10:28 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5666.49 Median:5856.59 stddev:637.26 (10.9%) stddev-sans-first:600.61 13:10:28 INFO - PROCESS | 1668 | Values: 2882.1 3448.5 3454.7 3488.2 3513.0 5579.9 5637.9 5638.0 5660.3 5675.9 5614.5 5638.3 5694.4 5707.3 5772.6 5061.6 5063.5 5086.1 5089.0 5222.3 5224.0 5226.6 5242.5 5278.8 5288.7 5051.9 5129.7 5151.7 5161.5 5188.6 5108.5 5150.8 5156.7 5158.8 5167.5 5067.6 5104.9 5110.1 5117.7 5125.8 5550.1 5554.1 5571.2 5578.4 5594.8 5660.9 6097.2 6204.6 6205.4 6230.1 5057.1 6260.7 6269.3 6274.8 6285.9 5726.6 5735.6 5748.1 5757.2 5810.5 6186.5 6263.1 6311.4 6339.2 6359.4 6046.6 6073.3 6094.0 6095.5 6096.6 5654.7 5892.6 6083.0 6217.9 6238.4 6095.5 6102.4 6123.3 6154.9 6163.6 6178.9 6181.2 6199.6 6206.8 6217.2 4760.3 4880.1 4880.8 4882.4 4896.1 4324.2 4339.3 4367.6 4412.7 4421.0 5599.3 5601.5 5619.3 5620.2 5622.7 6047.6 6176.6 6218.5 6219.6 6222.4 5584.8 5592.0 5673.0 5695.1 5713.5 5319.1 5328.0 5332.0 5332.7 5334.3 6192.8 6273.2 6276.2 6302.5 6303.7 6104.5 6127.2 6127.8 6133.1 6141.2 6243.5 6249.5 6299.4 6309.4 6329.4 6133.9 6139.9 6153.5 6153.7 6159.7 6220.1 6223.0 6224.1 6228.6 6261.5 5847.6 5922.8 5963.4 6016.8 6038.2 5033.5 5165.9 5913.2 6024.3 6033.2 5856.6 5892.5 5897.7 5898.7 5914.0 5885.2 5912.3 6012.5 6089.7 6114.5 5707.8 5893.4 5897.8 5898.0 5924.8 13:10:28 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:59457.67 Median:36831.76 stddev:118476.46 (321.7%) stddev-sans-first:118726.01 13:10:28 INFO - PROCESS | 1668 | Values: 462.9 571.3 572.6 632.2 642.1 30347.0 38630.2 38998.4 39008.8 39022.0 41817.2 42194.8 42222.5 42251.0 42452.0 9362.5 9606.0 9612.6 9616.9 9621.9 7963.6 9462.7 9472.3 9485.5 9493.3 9477.0 9633.4 9643.8 9647.5 9658.6 8553.2 9394.0 9560.6 9623.3 9629.7 9551.8 9571.6 9578.7 9587.8 9688.6 41191.0 41477.6 41629.6 41753.2 41756.2 3162.7 3382.2 3383.0 3574.3 3814.3 28348.3 29003.1 29999.9 30275.1 30283.5 2774.6 2848.5 2852.3 2865.5 2878.7 399406.0 474631.0 475657.0 475790.2 478079.0 66851.7 67494.0 67921.0 67942.7 67979.3 70717.9 70901.6 70977.6 71121.6 71128.6 16540.6 16734.2 16751.0 16757.7 16786.3 12692.6 12732.9 12735.3 12738.2 12748.4 18825.9 21121.3 21122.6 21128.3 21164.3 6663.4 7738.9 7905.8 7914.5 7971.6 934.7 984.9 1024.8 1130.6 1134.5 28042.6 28083.7 28487.6 28762.0 28784.9 1088.8 1122.9 1149.3 1168.7 1174.2 14429.0 14628.5 14939.4 15244.4 15297.7 505323.0 505520.0 509616.0 513234.0 513283.0 59429.4 59477.4 59542.7 59660.0 59698.4 1329.6 1387.7 1447.3 1448.2 1486.7 25205.1 28333.3 29115.7 29133.8 29184.6 46161.0 46382.0 46653.5 46726.3 46739.5 350339.0 353157.0 353539.0 353917.0 354281.0 28502.1 32751.7 33812.5 33820.3 33995.3 41458.8 42045.6 42178.0 42216.8 42575.6 30223.4 35457.8 36830.6 36832.9 37436.4 35824.6 36003.6 36298.5 36496.0 36558.7 30926.7 33592.0 35878.8 36102.5 36637.3 30557.7 31062.5 31345.6 31359.0 31402.0 20491.6 23200.4 23350.8 23545.8 24296.9 13:10:28 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:32472.32 Median:358.97 stddev:93212.46 (25966.7%) stddev-sans-first:93442.75 13:10:28 INFO - PROCESS | 1668 | Values: 356.9 361.1 363.9 368.1 372.9 19190.9 19406.0 20907.7 20916.7 20917.4 16749.6 20222.8 20622.4 20911.9 20921.8 5692.2 5868.1 5893.7 5904.2 5913.7 4104.4 4370.4 6205.9 6502.6 6513.3 6180.9 6440.3 6451.9 6454.4 6458.2 5677.8 6198.6 6232.4 6333.2 6449.1 3673.6 5035.8 5561.7 5561.8 5569.7 24169.6 24691.4 25575.7 25949.9 25967.6 2337.9 2373.9 2412.4 2531.8 2535.8 12501.8 13654.1 13981.7 14375.0 14898.9 1548.8 1633.5 1706.6 1708.7 1719.2 97601.0 99532.5 100281.5 100552.0 102326.0 9814.3 9966.7 10207.2 10255.9 10313.8 12638.4 12738.7 12765.0 12776.6 12790.8 8100.5 8345.0 8359.6 8456.6 8478.3 7537.0 7886.5 8598.3 8599.5 8734.7 5980.9 5988.0 6016.4 6020.4 6040.5 1530.3 1608.6 1635.5 1697.7 1772.2 890.0 961.4 969.3 1001.2 1015.3 19096.6 19378.0 19732.6 19766.6 20248.4 885.0 949.4 975.5 1020.3 1030.7 11077.0 11375.7 11387.6 11396.4 11495.8 552225.0 558559.0 566237.7 566853.0 568281.0 101948.0 103799.5 104689.0 107218.9 108201.0 989.2 1030.8 1043.9 1046.6 1047.2 17656.0 17782.7 18126.2 18464.1 18499.2 48765.0 49419.0 49872.8 50500.5 50996.7 70035.0 70675.0 74068.3 74700.6 74741.9 7507.1 7522.6 7668.8 7761.5 8114.6 7574.5 12031.9 12078.8 12283.9 12429.6 8374.6 10084.9 10420.9 10607.6 10731.4 9288.3 9794.0 9863.1 10247.4 10707.4 6547.7 7561.9 10862.3 10873.7 11250.9 7647.5 7837.8 7878.3 7962.3 8044.7 9149.4 9313.6 10799.8 10839.2 11170.2 13:10:28 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6092.12 Median:533.28 stddev:3240.40 (607.6%) stddev-sans-first:3230.67 13:10:28 INFO - PROCESS | 1668 | Values: 1445.7 1593.2 1620.3 1901.5 2024.5 8004.7 8631.5 8741.2 8779.9 8781.3 8480.0 8736.9 8759.5 8766.9 8771.8 2173.9 2401.5 2461.2 2465.4 2506.3 2482.0 2489.3 2492.5 2494.3 2495.8 2390.6 2447.3 2464.7 2471.6 2471.8 2432.3 2455.1 2467.4 2484.0 2493.4 2391.6 2411.0 2414.7 2419.9 2421.2 8767.0 8848.3 8848.4 8848.8 8849.9 5430.8 5572.9 5573.5 5598.5 5608.3 3574.3 3697.3 3736.0 3759.0 3765.1 1046.8 1059.7 1062.4 1074.2 1077.6 12023.8 12026.3 12032.2 12089.2 12091.8 4870.5 4897.5 4963.4 4964.5 5003.0 10113.7 10143.9 10163.8 10165.9 10172.7 5563.9 5576.2 5576.3 5577.2 5591.8 4126.9 4437.4 4558.9 4572.0 4787.9 3701.2 3823.5 3899.2 3965.1 3976.4 1312.8 1324.9 1325.5 1340.2 1343.7 1282.4 1284.7 1309.4 1342.3 1350.1 8089.6 8106.8 8277.7 8280.1 8285.9 517.3 531.2 532.6 534.0 534.0 6187.8 6250.1 6311.2 6317.1 6321.7 10616.4 10857.5 10863.0 10940.6 10961.2 10395.8 10687.1 10694.1 10809.4 10851.1 8368.7 8384.5 8454.5 8468.4 8478.2 7647.8 7983.8 7993.1 8006.9 8036.2 9399.2 9518.2 9722.1 9759.1 9856.1 9613.5 9974.7 10015.5 10076.3 10257.4 7505.9 7525.9 7541.3 7584.5 7595.8 8283.8 8309.3 8373.8 8374.4 8382.4 6751.3 7111.5 7367.9 7466.5 7611.2 7286.2 7324.2 7373.8 7380.2 7383.8 7779.5 7813.0 7877.0 7878.8 7892.7 7004.7 7100.5 7172.7 7178.5 7184.8 7100.8 7157.9 7174.2 7176.9 7180.4 13:10:28 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5617.38 Median:6407.84 stddev:1810.06 (28.2%) stddev-sans-first:1770.99 13:10:28 INFO - PROCESS | 1668 | Values: 323.9 328.3 330.4 333.2 336.5 4979.7 6391.7 6393.0 6412.2 6429.9 5681.3 6407.9 6417.5 6432.7 6447.7 4479.9 4556.4 4642.4 4678.9 4702.6 4747.7 4748.5 4757.5 4760.9 4768.5 4659.9 4661.4 4674.2 4692.1 4705.4 4502.1 4530.4 4655.8 4672.5 4707.6 3317.3 4028.7 4039.9 4044.0 4044.6 5999.0 6016.9 6020.1 6088.8 6122.5 5523.1 5528.9 5530.8 5539.2 5545.6 6788.0 6791.3 6801.8 6805.1 6815.2 4264.9 4471.7 4498.7 4571.7 4576.0 7202.9 7237.6 7269.8 7282.2 7311.2 4528.4 4538.8 4540.0 4541.9 4550.7 4601.9 4614.7 4622.8 4630.7 4632.6 5437.2 5443.0 5454.6 5471.2 5472.8 6658.1 6863.3 6917.3 6920.9 6932.3 1565.6 1567.3 1583.3 1591.6 1592.8 1007.5 1010.6 1026.2 1032.5 1033.1 6207.4 6317.6 6407.8 6555.1 6563.8 5908.4 7200.7 7216.4 7224.5 7235.4 6187.8 6518.1 6523.1 6526.2 6530.2 3271.3 3827.7 3832.2 3834.6 3838.2 7242.2 7576.1 7576.2 7576.4 7586.2 7370.9 7384.9 7393.5 7414.0 7428.8 7478.9 7503.5 7508.4 7516.0 7560.8 7170.9 7175.8 7187.5 7193.6 7204.4 6759.5 7027.4 7045.0 7051.5 7063.6 6069.4 7491.1 7528.3 7532.9 7540.9 4480.0 4535.4 4540.0 4544.0 4559.5 5788.3 7071.8 7084.3 7084.9 7089.4 6559.8 6846.9 6857.5 6882.9 6916.8 6860.8 6889.4 6901.6 6909.7 6919.7 6756.3 6769.2 6772.3 6773.0 6773.2 6880.8 6900.8 6916.3 6919.8 6930.4 6499.1 6522.9 6630.0 6676.4 6787.9 13:10:28 INFO - PROCESS | 1668 | 13:10:28 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:17924.88 Median:32167.66 stddev:25016.19 (77.8%) stddev-sans-first:25052.50 13:10:28 INFO - PROCESS | 1668 | Values: 589.7 738.3 748.5 755.5 759.8 14748.7 14984.5 14995.1 15001.2 15029.9 13729.0 13851.4 13855.9 13859.9 13866.0 743.7 761.2 914.1 943.2 947.6 934.4 951.8 954.1 954.3 954.5 1002.0 1003.7 1005.0 1005.8 1009.0 786.9 800.8 806.8 957.7 995.1 747.1 747.6 747.9 749.1 750.7 14489.0 14538.2 14552.0 14563.2 14573.0 12156.9 12333.1 12418.2 12571.4 12639.0 9247.3 9661.9 9828.7 9841.3 10387.9 3488.1 3501.4 3521.8 3559.6 3760.8 78744.4 78881.6 78889.2 78906.8 79298.6 9213.0 9330.7 9532.5 9600.6 9770.7 21653.0 21686.9 21692.8 21726.2 21776.1 7355.5 7432.3 7465.1 7485.0 7542.6 4062.8 4092.0 4115.5 4120.9 4231.9 3536.8 3567.4 3596.0 3597.2 3601.5 644.4 656.2 661.1 661.3 664.5 552.7 580.3 603.0 613.9 633.2 7465.9 8142.2 8247.6 8281.8 8331.7 505.3 556.7 585.9 593.7 639.6 3795.6 3823.4 3837.3 3888.3 3940.1 90030.0 90179.0 91497.5 91718.1 91873.5 77340.6 77572.4 78304.0 78394.0 78470.0 63695.7 64022.7 65086.0 65120.3 65416.7 7754.4 8221.3 8565.8 8609.3 8789.5 46920.8 47740.3 48255.8 48631.5 52072.5 64816.0 65170.7 65489.0 65551.0 66151.7 10690.8 10709.9 10846.5 11111.8 11488.4 11952.7 12041.8 12174.8 12216.6 12399.8 9540.3 11231.3 11427.2 11476.4 11593.0 9897.2 11353.3 11372.1 11727.6 11763.5 10914.2 11070.6 11223.4 11329.6 11593.5 9483.1 9636.2 9703.3 9758.0 10035.7 8590.6 8985.2 9570.5 9635.2 9743.1 13:10:28 INFO - PROCESS | 1668 | -------- Summary: end -------- 13:10:28 INFO - PROCESS | 1668 | 13:10:29 INFO - TEST-INFO | 1668: exit 0 13:10:29 INFO - TEST-OK | dromaeo_css | took 1113221ms 13:10:29 INFO - TEST-START | kraken 13:10:29 INFO - operating with platform_type : mac_ 13:10:29 INFO - Initialising browser for kraken test... 13:10:29 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpho_FRp/profile http://localhost:49275/getInfo.html) 13:10:31 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 13:10:31 INFO - PROCESS | 1674 | colorDepth:24 13:10:31 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 13:10:31 INFO - PROCESS | 1674 | __metrics 13:10:31 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:10:31 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:10:32 INFO - TEST-INFO | 1674: exit 0 13:10:32 INFO - Browser initialized. 13:10:32 INFO - Running cycle 1/1 for kraken test... 13:10:32 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpho_FRp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:43 INFO - PROCESS | 1676 | RSS: Main: 236756992 13:10:43 INFO - PROCESS | 1676 | 13:10:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:47 INFO - PROCESS | 1676 | RSS: Main: 283009024 13:10:47 INFO - PROCESS | 1676 | 13:10:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 13:10:50 INFO - PROCESS | 1676 | RSS: Main: 293146624 13:10:50 INFO - PROCESS | 1676 | 13:10:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 13:10:54 INFO - PROCESS | 1676 | RSS: Main: 279359488 13:10:54 INFO - PROCESS | 1676 | 13:10:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 13:10:56 INFO - PROCESS | 1676 | RSS: Main: 281722880 13:10:56 INFO - PROCESS | 1676 | 13:10:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:59 INFO - PROCESS | 1676 | RSS: Main: 282402816 13:10:59 INFO - PROCESS | 1676 | 13:11:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:02 INFO - PROCESS | 1676 | RSS: Main: 282386432 13:11:02 INFO - PROCESS | 1676 | 13:11:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 13:11:06 INFO - PROCESS | 1676 | RSS: Main: 282443776 13:11:06 INFO - PROCESS | 1676 | 13:11:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 13:11:09 INFO - PROCESS | 1676 | RSS: Main: 282767360 13:11:09 INFO - PROCESS | 1676 | 13:11:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:12 INFO - PROCESS | 1676 | RSS: Main: 314241024 13:11:12 INFO - PROCESS | 1676 | 13:11:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:14 INFO - PROCESS | 1676 | RSS: Main: 315256832 13:11:14 INFO - PROCESS | 1676 | 13:11:16 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:11:17 INFO - PROCESS | 1676 | RSS: Main: 321110016 13:11:17 INFO - PROCESS | 1676 | 13:11:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:11:20 INFO - PROCESS | 1676 | RSS: Main: 322236416 13:11:20 INFO - PROCESS | 1676 | 13:11:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:11:23 INFO - PROCESS | 1676 | RSS: Main: 322285568 13:11:23 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 13:11:25 INFO - PROCESS | 1676 | RSS: Main: 385056768 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | __start_tp_report 13:11:25 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 13:11:25 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 13:11:25 INFO - PROCESS | 1676 | |i|pagename|runs| 13:11:25 INFO - PROCESS | 1676 | |0;ai-astar;109;108;110;110;112;110;119;112;111;111 13:11:25 INFO - PROCESS | 1676 | |1;audio-beat-detection;161;147;174;156;120;144;143;120;162;118 13:11:25 INFO - PROCESS | 1676 | |2;audio-dft;186;186;190;189;186;187;184;182;181;187 13:11:25 INFO - PROCESS | 1676 | |3;audio-fft;78;76;70;150;86;60;57;62;118;56 13:11:25 INFO - PROCESS | 1676 | |4;audio-oscillator;92;126;168;102;78;82;119;80;77;124 13:11:25 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;86;83;87;83;86;84;87;84;86;83 13:11:25 INFO - PROCESS | 1676 | |6;imaging-darkroom;100;143;93;92;91;101;93;93;92;93 13:11:25 INFO - PROCESS | 1676 | |7;imaging-desaturate;87;86;87;87;105;144;72;130;145;90 13:11:25 INFO - PROCESS | 1676 | |8;json-parse-financial;53;55;55;55;55;52;55;62;57;71 13:11:25 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;62;65;71;78;72;70;68;66;68;68 13:11:25 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;83;84;84;84;84;84;82;83;85;84 13:11:25 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;137;132;136;110;121;125;124;120;128;126 13:11:25 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;139;127;140;136;138;128;138;140;136;137 13:11:25 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;69;68;65;65;67;68;66;66;67;67 13:11:25 INFO - PROCESS | 1676 | __end_tp_report 13:11:25 INFO - PROCESS | 1676 | __start_cc_report 13:11:25 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1332 13:11:25 INFO - PROCESS | 1676 | __end_cc_report 13:11:25 INFO - PROCESS | 1676 | __startTimestamp1459627885368__endTimestamp 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | ------- Summary: start ------- 13:11:25 INFO - PROCESS | 1676 | Number of tests: 14 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.01 (2.7%) stddev-sans-first:3.09 13:11:25 INFO - PROCESS | 1676 | Values: 109.0 108.0 110.0 110.0 112.0 110.0 119.0 112.0 111.0 111.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.50 stddev:19.70 (13.0%) stddev-sans-first:19.97 13:11:25 INFO - PROCESS | 1676 | Values: 161.0 147.0 174.0 156.0 120.0 144.0 143.0 120.0 162.0 118.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:185.80 Median:186.50 stddev:2.82 (1.5%) stddev-sans-first:2.99 13:11:25 INFO - PROCESS | 1676 | Values: 186.0 186.0 190.0 189.0 186.0 187.0 184.0 182.0 181.0 187.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:81.30 Median:66.00 stddev:30.39 (46.0%) stddev-sans-first:32.21 13:11:25 INFO - PROCESS | 1676 | Values: 78.0 76.0 70.0 150.0 86.0 60.0 57.0 62.0 118.0 56.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:77.50 stddev:29.46 (38.0%) stddev-sans-first:30.88 13:11:25 INFO - PROCESS | 1676 | Values: 92.0 126.0 168.0 102.0 78.0 82.0 119.0 80.0 77.0 124.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.72 13:11:25 INFO - PROCESS | 1676 | Values: 86.0 83.0 87.0 83.0 86.0 84.0 87.0 84.0 86.0 83.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:99.10 Median:92.50 stddev:15.80 (17.1%) stddev-sans-first:16.76 13:11:25 INFO - PROCESS | 1676 | Values: 100.0 143.0 93.0 92.0 91.0 101.0 93.0 93.0 92.0 93.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:103.30 Median:86.50 stddev:26.59 (30.7%) stddev-sans-first:27.54 13:11:25 INFO - PROCESS | 1676 | Values: 87.0 86.0 87.0 87.0 105.0 144.0 72.0 130.0 145.0 90.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.00 stddev:5.60 (10.2%) stddev-sans-first:5.75 13:11:25 INFO - PROCESS | 1676 | Values: 53.0 55.0 55.0 55.0 55.0 52.0 55.0 62.0 57.0 71.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:4.37 (6.3%) stddev-sans-first:3.88 13:11:25 INFO - PROCESS | 1676 | Values: 62.0 65.0 71.0 78.0 72.0 70.0 68.0 66.0 68.0 68.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 13:11:25 INFO - PROCESS | 1676 | Values: 83.0 84.0 84.0 84.0 84.0 84.0 82.0 83.0 85.0 84.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:127.00 stddev:8.05 (6.3%) stddev-sans-first:7.47 13:11:25 INFO - PROCESS | 1676 | Values: 137.0 132.0 136.0 110.0 121.0 125.0 124.0 120.0 128.0 126.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:138.00 stddev:4.65 (3.4%) stddev-sans-first:4.80 13:11:25 INFO - PROCESS | 1676 | Values: 139.0 127.0 140.0 136.0 138.0 128.0 138.0 140.0 136.0 137.0 13:11:25 INFO - PROCESS | 1676 | 13:11:25 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.32 (2.0%) stddev-sans-first:1.13 13:11:25 INFO - PROCESS | 1676 | Values: 69.0 68.0 65.0 65.0 67.0 68.0 66.0 66.0 67.0 67.0 13:11:25 INFO - PROCESS | 1676 | -------- Summary: end -------- 13:11:25 INFO - PROCESS | 1676 | 13:11:26 INFO - TEST-INFO | 1676: exit 0 13:11:26 INFO - TEST-OK | kraken | took 57000ms 13:11:26 INFO - SUITE-END | took 1170s 13:11:26 INFO - Completed test suite (00:19:30) 13:11:26 INFO - javascript benchmark 13:11:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2882.0921409755924, 3448.49996750471, 3454.7236221102316, 3488.2151515908918, 3513.0339156731898, 5579.9163012554845, 5637.8590535236635, 5638.0, 5660.320761508615, 5675.8581035474135, 5614.466625670555, 5638.267025286707, 5694.430556944303, 5707.286589176353, 5772.624779389337, 5061.5950723942, 5063.493650634926, 5086.084504789136, 5089.0, 5222.32109825724, 5224.0, 5226.634135610509, 5242.501962313593, 5278.762455689484, 5288.65623734456, 5051.9494805051845, 5129.666571672829, 5151.6908985461, 5161.509656582619, 5188.558972487324, 5108.463611320795, 5150.819721309774, 5156.690598564098, 5158.793648254065, 5167.509086636764, 5067.594592432597, 5104.948950510522, 5110.131277682765, 5117.667351622133, 5125.820596279113, 5550.0564903966015, 5554.111342185231, 5571.164325351189, 5578.414266501999, 5594.832155035356, 5660.915086273709, 6097.231802777189, 6204.565680402374, 6205.441510264098, 6230.127782110463, 5057.0897238497055, 6260.655663938482, 6269.341719119518, 6274.780382686584, 6285.9057114143325, 5726.570507211975, 5735.627184233053, 5748.128371546265, 5757.222774925373, 5810.4770570648425, 6186.505079593621, 6263.060540918898, 6311.368863113744, 6339.175907132043, 6359.427651511293, 6046.606970546901, 6073.271207455134, 6093.969530152321, 6095.481884039907, 6096.573239873166, 5654.7276862706385, 5892.616979896293, 6083.0, 6217.937820621826, 6238.438540531283, 6095.512359011268, 6102.420270074336, 6123.326434092246, 6154.876902461926, 6163.599366041282, 6178.938210617836, 6181.196444462191, 6199.628022318675, 6206.813795586139, 6217.160683307786, 4760.309755085494, 4880.1215781159735, 4880.804767809319, 4882.36529251195, 4896.143174944442, 4324.200022995693, 4339.284018137035, 4367.606915377632, 4412.6690498212765, 4421.0, 5599.272094627754, 5601.5238704710555, 5619.269494965628, 5620.185073164368, 5622.662640241599, 6047.576669633171, 6176.567640265228, 6218.502519798405, 6219.626822390671, 6222.408871157323, 5584.832455026356, 5592.0, 5673.035583950738, 5695.145728140812, 5713.457221563945, 5319.0957537218765, 5328.0, 5332.0, 5332.653377530448, 5334.333208348957, 6192.845178870564, 6273.153124328249, 6276.215473065867, 6302.464290535264, 6303.684815759286, 6104.4591554472245, 6127.234095738033, 6127.769884593299, 6133.05924499315, 6141.179174348115, 6243.531735119975, 6249.50003999688, 6299.401556852092, 6309.3690630936535, 6329.430351268408, 6133.916185115316, 6139.938600614116, 6153.538484613761, 6153.692315384303, 6159.6612186330185, 6220.066989951543, 6223.0354295084335, 6224.097505861534, 6228.626282423069, 6261.467775238973, 5847.590668653153, 5922.7927022554, 5963.373845746134, 6016.849578760391, 6038.215032045806, 5033.471485494117, 5165.870853228699, 5913.201717768046, 6024.277086749618, 6033.215681961317, 5856.59003869725, 5892.499137573354, 5897.675627840338, 5898.675572843363, 5914.0, 5885.205497257815, 5912.260967379078, 6012.549058820693, 6089.665068421279, 6114.510839132948, 5707.7716891325545, 5893.351731309467, 5897.823065308047, 5898.0, 5924.763009479745], "unit": "score", "name": "dojo.html", "value": 5626.337353345396}, {"lowerIsBetter": false, "replicates": [462.9282461218512, 571.3058633759983, 572.5963195946855, 632.1844820181964, 642.1331202876117, 30347.0, 38630.22739545211, 38998.415023774665, 39008.80495597518, 39022.024449388744, 41817.16365672685, 42194.7890260549, 42222.52221172259, 42251.0, 42452.0, 9362.531873406353, 9606.0, 9612.615495380176, 9616.855747163798, 9621.855672164887, 7963.562004089773, 9462.668806591771, 9472.336936414455, 9485.525723713821, 9493.288003399739, 9477.0, 9633.421994680306, 9643.758906027335, 9647.469389183592, 9658.565364558612, 8553.230209281131, 9393.953030234874, 9560.61757529698, 9623.326367154303, 9629.662961796339, 9551.808963820684, 9571.569279382375, 9578.6647467339, 9587.760305992337, 9688.564014619358, 41191.0, 41477.585224147675, 41629.58370416288, 41753.1649367011, 41756.16487670229, 3162.652108268089, 3382.154461384654, 3382.96617033829, 3574.338747331726, 3814.256220037094, 28348.291292717848, 29003.12990610285, 29999.850000750073, 30275.091747247618, 30283.545746813816, 2774.611554382388, 2848.5299925512268, 2852.3154442933755, 2865.498537755905, 2878.7409133177907, 399406.0, 474631.0, 475657.0, 475790.24209757807, 478079.0, 66851.66574167195, 67494.0, 67921.0, 67942.66028669824, 67979.3202067983, 70717.93923091158, 70901.64549177221, 70977.64511177411, 71121.6443917777, 71128.64435677892, 16540.586485337964, 16734.24695888688, 16751.0, 16757.664846703243, 16786.32854685799, 12692.555760548337, 12732.872671273353, 12735.29955852437, 12738.235705857678, 12748.426320815586, 18825.94608541187, 21121.26075587347, 21122.57754844925, 21128.260510882046, 21164.259250926145, 6663.400293973566, 7738.922610773933, 7905.841883162419, 7914.525128492309, 7971.641276142587, 934.6775362499926, 984.9458279794537, 1024.764304210021, 1130.5534313945946, 1134.4554613785429, 28042.579361309596, 28083.71916280811, 28487.57268640972, 28761.99333023334, 28784.856075719486, 1088.78768640116, 1122.910167186623, 1149.2816989381636, 1168.7019809948579, 1174.2015429507846, 14429.0, 14628.48800292006, 14939.356670766207, 15244.390224391122, 15297.694046119237, 505323.0, 505520.0, 509616.0, 513234.0, 513283.0, 59429.40570594325, 59477.40522594805, 59542.70228648829, 59660.0, 59698.40301597015, 1329.5612447892172, 1387.7163623648084, 1447.2835946206694, 1448.246911605959, 1486.724955883165, 25205.11782087618, 28333.291667708472, 29115.7088429113, 29133.834646613897, 29184.562231566968, 46161.0, 46382.0, 46653.53346466492, 46726.299105514125, 46739.53260467352, 350339.0, 353157.0, 353539.0, 353917.0, 354281.0, 28502.144935651133, 32751.672483274862, 33812.492812607336, 33820.32359352848, 33995.320093598486, 41458.79270603628, 42045.57954420416, 42178.0, 42216.78891605645, 42575.574244257165, 30223.395532088794, 35457.82271088628, 36830.63169368272, 36832.895013149646, 37436.43845342377, 35824.567017319016, 36003.63996360003, 36298.455523166645, 36496.0, 36558.7204447843, 30926.690733092382, 33591.99224023283, 35878.820605896806, 36102.45846312255, 36637.26725465422, 30557.694423055484, 31062.54243380334, 31345.551989281616, 31359.0, 31402.0, 20491.565590409125, 23200.419989499722, 23350.76649233486, 23545.764542354358, 24296.87851560731], "unit": "score", "name": "ext.html", "value": 19489.20958348116}, {"lowerIsBetter": false, "replicates": [356.8626078959601, 361.0756463453559, 363.890832750175, 368.1312103435891, 372.8639046747938, 19190.94449805262, 19406.02969851507, 20907.686384704222, 20916.686249706265, 20917.372478825622, 16749.581260468494, 20222.786632802043, 20622.381328560128, 20911.895440522778, 20921.849298288587, 5692.231548740919, 5868.09044598088, 5893.675847828367, 5904.1734157218025, 5913.674747888865, 4104.42538044674, 4370.38814565961, 6205.9069113963105, 6502.577332473397, 6513.283538810727, 6180.876382472348, 6440.291567927524, 6451.903221451682, 6454.354564543555, 6458.192725909262, 5677.829665110012, 6198.605313804403, 6232.439080482778, 6333.176687030679, 6449.097126402307, 3673.577538583044, 5035.823746168867, 5561.749721262553, 5561.77752889884, 5569.721513924287, 24169.637455438184, 24691.38271543208, 25575.74424255752, 25949.870250648815, 25967.610485842728, 2337.883105844701, 2373.8694371809715, 2412.408959804859, 2531.822772405914, 2535.77178053976, 12501.812472812915, 13654.112482688593, 13981.720365592733, 14374.993750437474, 14898.851011489854, 1548.783170356151, 1633.4527933142292, 1706.6330738891197, 1708.7436884467304, 1719.243532845544, 97601.0, 99532.50233748858, 100281.49859250657, 100552.0, 102326.0, 9814.312998090065, 9966.700998970042, 10207.183425325957, 10255.94872025635, 10313.84529232062, 12638.368081595883, 12738.745225095447, 12765.0, 12776.552820651232, 12790.808137877939, 8100.513969161751, 8345.040320363236, 8359.623816928131, 8456.619452124669, 8478.321734261244, 7537.0, 7886.526808391515, 8598.269147122439, 8599.484030958163, 8734.737957861274, 5980.910286345708, 5988.0, 6016.398360164036, 6020.397960203944, 6040.516758659297, 1530.2501774130596, 1608.6460978584694, 1635.4766474727974, 1697.702901992171, 1772.2113659421434, 889.9510526921082, 961.3847137831793, 969.3214749675255, 1001.234055947201, 1015.2740790334946, 19096.61806763857, 19378.0, 19732.60534789296, 19766.60466790685, 20248.392548223575, 884.9690111020717, 949.3639261694681, 975.4829940131741, 1020.2908978260186, 1030.7474668706216, 11077.0, 11375.658730238107, 11387.601433949772, 11396.373199473943, 11495.827562586568, 552225.0, 558559.0, 566237.7009839203, 566853.0, 568281.0, 101947.98052019384, 103799.4810025945, 104689.0, 107218.92781072245, 108201.0, 989.1987490133015, 1030.7577719236124, 1043.9425831579183, 1046.6022911293812, 1047.1988928469727, 17656.0, 17782.733259001383, 18126.184321705292, 18464.07679615987, 18499.167537460577, 48765.0, 49419.0, 49872.75063624659, 50500.49499505105, 50996.74501627468, 70035.0, 70675.0, 74068.25931740613, 74700.62649686717, 74741.87887181588, 7507.099148102263, 7522.586257755657, 7668.808279792826, 7761.456698031084, 8114.594270286344, 7574.545527268381, 12031.939840300742, 12078.75842483163, 12283.938580307042, 12429.564965226175, 8374.623141958748, 10084.949575252076, 10420.895791041992, 10607.575696972035, 10731.40977246259, 9288.303377246868, 9793.951030244803, 9863.112319891245, 10247.38515689061, 10707.357558546511, 6547.672616369067, 7561.924380756122, 10862.293950893167, 10873.728156796144, 11250.943745281222, 7647.502912310682, 7837.843243135219, 7878.290953814184, 7962.283394494523, 8044.678212871419, 9149.359544831797, 9313.627454901729, 10799.784004320027, 10839.187060970302, 11170.218084733991], "unit": "score", "name": "jquery.html", "value": 9278.524335002954}, {"lowerIsBetter": false, "replicates": [1445.681949971006, 1593.1795125510362, 1620.3437607768853, 1901.5246188452886, 2024.5242368043498, 8004.679812807488, 8631.525266110362, 8741.169588889044, 8779.868301975475, 8781.253593444564, 8480.0, 8736.912630873689, 8759.518226497556, 8766.868496972551, 8771.780705482366, 2173.913043478267, 2401.519696060786, 2461.212412028152, 2465.4329504214043, 2506.348349429143, 2481.962770558443, 2489.2781093482868, 2492.47657991821, 2494.276659768674, 2495.837770544918, 2390.5935990881503, 2447.2535876557645, 2464.691913510811, 2471.6416119662726, 2471.789897858675, 2432.3311089450367, 2455.1218317986754, 2467.3708204407762, 2484.0312278211513, 2493.3891196656755, 2391.557561851063, 2411.0114852910224, 2414.6860908081835, 2419.8669073200967, 2421.225207933462, 8767.0, 8848.29213662912, 8848.380613357067, 8848.778780530474, 8849.911500884973, 5430.782768689248, 5572.944270557283, 5573.470520300565, 5598.524125449342, 5608.270924779753, 3574.267275208576, 3697.279030589036, 3735.9813200933822, 3758.981205093957, 3765.058735316171, 1046.7592453735608, 1059.7403636109125, 1062.3731998121145, 1074.1675201718651, 1077.6066735641514, 12023.759524809542, 12026.27842329463, 12032.217905836093, 12089.153759236857, 12091.758164836741, 4870.465803271958, 4897.477798933552, 4963.379577552806, 4964.453910069889, 5003.024410239968, 10113.696589102192, 10143.898561014295, 10163.847542286872, 10165.898341016644, 10172.745681358025, 5563.916541251884, 5576.191452239484, 5576.33084029919, 5577.247071645357, 5591.804286850022, 4126.8761937141935, 4437.378766972626, 4558.931616025762, 4571.994161284512, 4787.904241915142, 3701.1857391373856, 3823.5220597425323, 3899.161680238762, 3965.147493288957, 3976.363781794899, 1312.7768279392526, 1324.8675132486674, 1325.4830616059744, 1340.249460302234, 1343.7178192579668, 1282.435728279554, 1284.7237843863427, 1309.3911331230834, 1342.3020029584757, 1350.1359130156707, 8089.635966381527, 8106.837863242702, 8277.710280140167, 8280.130586288473, 8285.875711864326, 517.3171413733835, 531.2456312036917, 532.5792623827133, 533.9759710813023, 534.0413956947289, 6187.84530386735, 6250.062490626442, 6311.211098612674, 6317.147185129948, 6321.65230912295, 10616.363018218777, 10857.51141198648, 10863.0, 10940.56237750497, 10961.232713709964, 10395.792084158275, 10687.14502839771, 10694.144468442506, 10809.40548269837, 10851.077658398966, 8368.665253389918, 8384.455010424303, 8454.49273043607, 8468.407211495136, 8478.194571515696, 7647.808804779925, 7983.800404989922, 7993.080795708335, 8006.879896801669, 8036.236557527026, 9399.154076133182, 9518.190953769008, 9722.076402741728, 9759.072888075621, 9856.112949834549, 9613.51932403391, 9974.650887218913, 10015.549300281358, 10076.294659373774, 10257.384556926609, 7505.924940750522, 7525.924740752742, 7541.283578060075, 7584.469087163846, 7595.848083038198, 8283.792905177419, 8309.33525317961, 8373.790655233424, 8374.413791034813, 8382.371322150984, 6751.291114432914, 7111.502194846311, 7367.889481657672, 7466.514676546007, 7611.162772094955, 7286.1985181631035, 7324.194338622854, 7373.8156546086775, 7380.225076367119, 7383.778486645409, 7779.455438119504, 7812.960935195288, 7877.0, 7878.803029924297, 7892.723754668559, 7004.719811207495, 7100.538464999759, 7172.748953786592, 7178.497505174588, 7184.784456466105, 7100.822479438056, 7157.928420715934, 7174.174969878322, 7176.892346614909, 7180.3537681608905], "unit": "score", "name": "mootools.html", "value": 4881.1314787287965}, {"lowerIsBetter": false, "replicates": [323.89797213877625, 328.25649902969775, 330.373941381083, 333.2102916088869, 336.46334097115107, 4979.7261150636705, 6391.712372943217, 6392.968035159824, 6412.230532336121, 6429.871402571957, 5681.261436013323, 6407.871842563146, 6417.454516366103, 6432.742690292394, 6447.742090316394, 4479.888002799924, 4556.407667003285, 4642.442906851183, 4678.883027924295, 4702.6002789762915, 4747.691400059002, 4748.453927798296, 4757.524247575232, 4760.880977975544, 4768.47546769855, 4659.906801863961, 4661.44062712475, 4674.158651442739, 4692.108499385123, 4705.411823522059, 4502.144592527409, 4530.365748795171, 4655.790489427984, 4672.486026537078, 4707.646926480511, 3317.286783341569, 4028.738132021409, 4039.939400908989, 4044.0, 4044.6157615026527, 5999.010163323046, 6016.879662406771, 6020.096985452174, 6088.786892458743, 6122.540809439265, 5523.061079616475, 5528.9494995950645, 5530.760042182922, 5539.169124631298, 5545.639533430314, 6787.966060169717, 6791.252962174157, 6801.761938332184, 6805.149356330458, 6815.182178138605, 4264.850730224458, 4471.709338892994, 4498.730076195438, 4571.748553829538, 4575.95424045762, 7202.927970720278, 7237.601931893743, 7269.781906542759, 7282.235365286621, 7311.159216690043, 4528.366028755977, 4538.750368729686, 4540.0011997360525, 4541.909161816745, 4550.681452298373, 4601.907961840744, 4614.7461889595725, 4622.768861556909, 4630.699004564693, 4632.559906808848, 5437.238786569884, 5442.972785136049, 5454.563634909197, 5471.179323101566, 5472.753726082336, 6658.067870498134, 6863.2793556676825, 6917.273686262971, 6920.930790692129, 6932.306769323028, 1565.6399028223573, 1567.3260497985975, 1583.319172755703, 1591.5702760254667, 1592.8486793754807, 1007.4610083605236, 1010.5907107621425, 1026.235454586338, 1032.5250384823066, 1033.0702367868978, 6207.410296021871, 6317.5893566918, 6407.807765767035, 6555.115059467006, 6563.7702680405955, 5908.409159084057, 7200.747973820891, 7216.422686185093, 7224.4581656375985, 7235.421166306683, 6187.84530386744, 6518.087467754518, 6523.11937888379, 6526.216853977553, 6530.151080359523, 3271.329377477611, 3827.6746476549247, 3832.1952389998414, 3834.616538346143, 3838.1747924196434, 7242.167150777623, 7576.090869095744, 7576.204498527575, 7576.424015834643, 7586.203448637924, 7370.8894366584545, 7384.889226661604, 7393.48245622812, 7414.036175297285, 7428.777136685908, 7478.9252107479315, 7503.512271702322, 7508.361789247975, 7516.0, 7560.810979725551, 7170.892436613351, 7175.784726458214, 7187.496875218684, 7193.568385896863, 7204.351608355273, 6759.493038022069, 7027.367536921702, 7045.0, 7051.5063945523325, 7063.57618542889, 6069.362716914837, 7491.138519070377, 7528.284812942762, 7532.924670753222, 7540.886886696594, 4480.036792089716, 4535.3650488932235, 4540.046590215959, 4544.0, 4559.521250268674, 5788.334341550775, 7071.7878463646175, 7084.326988936043, 7084.893726594209, 7089.361957423856, 6559.836004099745, 6846.863062738817, 6857.485688573477, 6882.896756548756, 6916.827079323057, 6860.828479288058, 6889.414399776075, 6901.551399159039, 6909.689063992032, 6919.654017299014, 6756.324367563205, 6769.1876974763345, 6772.288909664611, 6773.017912402773, 6773.221079575912, 6880.793576192722, 6900.758473453405, 6916.273791251846, 6919.792406227822, 6930.44556435494, 6499.090127382265, 6522.934770652422, 6629.972354285093, 6676.365745254193, 6787.898181527183], "unit": "score", "name": "prototype.html", "value": 5014.200768484582}, {"lowerIsBetter": false, "replicates": [589.7022003888036, 738.2764890407401, 748.4985060009793, 755.516469459546, 759.8176437654964, 14748.705025899475, 14984.475543355984, 14995.100293982368, 15001.249937503137, 15029.924850375746, 13729.0, 13851.445942162301, 13855.930720346409, 13859.861401385982, 13866.0, 743.6690672650673, 761.2045412543905, 914.1041779056528, 943.2406912435487, 947.606743201574, 934.3786382055924, 951.8191543606728, 954.0983770337, 954.2556805691537, 954.5275088831038, 1002.0480543483683, 1003.7289931718432, 1004.9949750251238, 1005.7535903703603, 1009.0010889219693, 786.909505406877, 800.8158123631539, 806.753940048285, 957.683964291782, 995.0845222395413, 747.0997448075111, 747.5962979990799, 747.8878168274748, 749.1123019222239, 750.6734570461866, 14488.985770996034, 14538.200398978051, 14552.0, 14563.199024053672, 14573.0, 12156.878431215751, 12333.136680432373, 12418.192817466926, 12571.434285457177, 12639.0, 9247.306452016126, 9661.855072173852, 9828.655997040069, 9841.311108222428, 10387.948060259725, 3488.0930957950864, 3501.369753444379, 3521.8239088045493, 3559.5728512578658, 3760.793156376398, 78744.42511149745, 78881.60559197224, 78889.21110788875, 78906.81639775408, 79298.60350698268, 9212.953935230282, 9330.673426430043, 9532.475713835667, 9600.615975360908, 9770.658026969022, 21653.0, 21686.891565542388, 21692.783072169394, 21726.239581614886, 21776.128954841945, 7355.513136986434, 7432.293932076444, 7465.06686664167, 7484.962575187089, 7542.622868856645, 4062.7765472899273, 4092.01791570027, 4115.506139263308, 4120.876373708794, 4231.936520952188, 3536.823158842099, 3567.3578755823683, 3596.047047532406, 3597.244578638515, 3601.4957905893198, 644.4007073421762, 656.2387630348773, 661.0678942690782, 661.2858113237692, 664.5149041199951, 552.6656372894421, 580.2688612348471, 603.0200923499314, 613.9324674285825, 633.1705465839765, 7465.85068298631, 8142.226488483585, 8247.628856701464, 8281.792955176168, 8331.6667333306, 505.2875445621656, 556.6910364747604, 585.92382990211, 593.6853467662146, 639.6322114784018, 3795.6394142556414, 3823.388257878726, 3837.3092843288478, 3888.3389823730035, 3940.0517410567873, 90030.0, 90179.0, 91497.54251228701, 91718.08281917228, 91873.54063229641, 77340.61329693315, 77572.44855102866, 78304.0, 78394.0, 78470.0, 63695.681521593026, 64022.6798866012, 65086.0, 65120.34879651238, 65416.69166616641, 7754.418418618513, 8221.349321204452, 8565.828683426422, 8609.268212202032, 8789.516576588348, 46920.76539617417, 47740.2838957409, 48255.758721207574, 48631.5136848627, 52072.47927520828, 64816.0, 65170.69658606707, 65489.0, 65551.0, 66151.66924165348, 10690.839637405601, 10709.892901070889, 10846.511906964048, 11111.83332250033, 11488.425578720864, 11952.701182470508, 12041.819372709591, 12174.75650487003, 12216.633500994983, 12399.814002790146, 9540.33217674756, 11231.26996745209, 11427.200095993201, 11476.4261786912, 11593.0, 9897.208223341971, 11353.262037967506, 11372.147088968526, 11727.648170554898, 11763.47064382122, 10914.18143639246, 11070.612528561462, 11223.38271395081, 11329.603463878724, 11593.536258549564, 9483.099105584959, 9636.180924621485, 9703.272254581076, 9757.951210243904, 10035.749106272402, 8590.613422396133, 8985.236254918405, 9570.47362395075, 9635.22918166559, 9743.074407931235], "unit": "score", "name": "yui.html", "value": 6865.939549306216}], "name": "dromaeo_css", "value": 7450.053797449238}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 108.0, 110.0, 110.0, 112.0, 110.0, 119.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [161.0, 147.0, 174.0, 156.0, 120.0, 144.0, 143.0, 120.0, 162.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [186.0, 186.0, 190.0, 189.0, 186.0, 187.0, 184.0, 182.0, 181.0, 187.0], "unit": "score", "name": "audio-dft", "value": 185.8}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 70.0, 150.0, 86.0, 60.0, 57.0, 62.0, 118.0, 56.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [92.0, 126.0, 168.0, 102.0, 78.0, 82.0, 119.0, 80.0, 77.0, 124.0], "unit": "score", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 87.0, 83.0, 86.0, 84.0, 87.0, 84.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.9}, {"lowerIsBetter": true, "replicates": [100.0, 143.0, 93.0, 92.0, 91.0, 101.0, 93.0, 93.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 99.1}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 87.0, 87.0, 105.0, 144.0, 72.0, 130.0, 145.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 103.3}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 55.0, 55.0, 55.0, 52.0, 55.0, 62.0, 57.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 71.0, 78.0, 72.0, 70.0, 68.0, 66.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 84.0, 84.0, 84.0, 82.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [137.0, 132.0, 136.0, 110.0, 121.0, 125.0, 124.0, 120.0, 128.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 140.0, 136.0, 138.0, 128.0, 138.0, 140.0, 136.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 65.0, 65.0, 67.0, 68.0, 66.0, 66.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1453.0}]} 13:11:26 INFO - Return code: 0 13:11:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:11:26 ERROR - # TBPL SUCCESS # 13:11:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:11:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:11:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:11:26 INFO - 2016-04-02 13:11:26.686 screenresolution[1680:10283] starting screenresolution argv=screenresolution get 13:11:26 INFO - 2016-04-02 13:11:26.689 screenresolution[1680:10283] Display 0: 1600x1200x32@60 13:11:26 INFO - 2016-04-02 13:11:26.695 screenresolution[1681:10286] starting screenresolution argv=screenresolution list 13:11:26 INFO - Available Modes on Display 0 13:11:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:11:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:11:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:11:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:11:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:11:26 INFO - Intel Iris: 13:11:26 INFO - Chipset Model: Intel Iris 13:11:26 INFO - Type: GPU 13:11:26 INFO - Bus: Built-In 13:11:26 INFO - VRAM (Dynamic, Max): 1536 MB 13:11:26 INFO - Vendor: Intel (0x8086) 13:11:26 INFO - Device ID: 0x0a2e 13:11:26 INFO - Revision ID: 0x0009 13:11:26 INFO - Displays: 13:11:26 INFO - Display: 13:11:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:11:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:11:26 INFO - Display Serial Number: 1600x1200 60 13:11:26 INFO - Main Display: Yes 13:11:26 INFO - Mirror: Off 13:11:26 INFO - Online: Yes 13:11:26 INFO - Rotation: Supported 13:11:26 INFO - Return code: 0 13:11:26 INFO - Running post-action listener: _resource_record_post_action 13:11:26 INFO - Running post-run listener: _resource_record_post_run 13:11:27 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 32259584; Write bytes: 704698368; Read time: 325; Write time: 2150 13:11:27 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388741632; Write bytes: 382678528; Read time: 29500; Write time: 747 13:11:27 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 31329792; Write bytes: 301142528; Read time: 311; Write time: 1346 13:11:27 INFO - Running post-run listener: _upload_blobber_files 13:11:27 INFO - Blob upload gear active. 13:11:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:11:27 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 13:11:27 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'] 13:11:27 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 13:11:28 INFO - (blobuploader) - INFO - Open directory for files ... 13:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:11:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:29 INFO - (blobuploader) - INFO - Done attempting. 13:11:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:11:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:30 INFO - (blobuploader) - INFO - Done attempting. 13:11:30 INFO - (blobuploader) - INFO - Iteration through files over. 13:11:30 INFO - Return code: 0 13:11:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:11:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:11:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad05c215b6dd027ec3158c7baf4b3dc57c989a90852e9436990818b15e167d16f2bf7917d59df3097776dd931798f50af182b27cc699bfb2e100cac0cddca01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/addfed970ea2754524e05ee422543fa2a7c807cf7ef1953a0a8921647f11dcf697075e5957fa2333cd1da777a7f5a0aceee71930f0e2c1c08897dced48561aa7"} 13:11:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:11:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:11:30 INFO - Contents: 13:11:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad05c215b6dd027ec3158c7baf4b3dc57c989a90852e9436990818b15e167d16f2bf7917d59df3097776dd931798f50af182b27cc699bfb2e100cac0cddca01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/addfed970ea2754524e05ee422543fa2a7c807cf7ef1953a0a8921647f11dcf697075e5957fa2333cd1da777a7f5a0aceee71930f0e2c1c08897dced48561aa7"} 13:11:30 INFO - Running post-run listener: copy_logs_to_upload_dir 13:11:30 INFO - Copying logs to upload dir... 13:11:30 INFO - mkdir: /builds/slave/test/build/upload/logs 13:11:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.737537 ========= master_lag: 2.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-02 13:11:33.172612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-02 13:11:33.180367) ========= 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.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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/bad05c215b6dd027ec3158c7baf4b3dc57c989a90852e9436990818b15e167d16f2bf7917d59df3097776dd931798f50af182b27cc699bfb2e100cac0cddca01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/addfed970ea2754524e05ee422543fa2a7c807cf7ef1953a0a8921647f11dcf697075e5957fa2333cd1da777a7f5a0aceee71930f0e2c1c08897dced48561aa7"} build_url:https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011161 build_url: 'https://queue.taskcluster.net/v1/task/Trm34IKcRNeieHlbSEtoxg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad05c215b6dd027ec3158c7baf4b3dc57c989a90852e9436990818b15e167d16f2bf7917d59df3097776dd931798f50af182b27cc699bfb2e100cac0cddca01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/addfed970ea2754524e05ee422543fa2a7c807cf7ef1953a0a8921647f11dcf697075e5957fa2333cd1da777a7f5a0aceee71930f0e2c1c08897dced48561aa7"}' ========= master_lag: 1.50 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-02 13:11:34.691202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-04-02 13:11:34.691493) ========= 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.1XdopKfWvu/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.tFaPb027Ev/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.005274 ========= master_lag: 12.53 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-04-02 13:11:47.227768) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-02 13:11:47.236090) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-02 13:11:48.789056) ========= ========= Total master_lag: 57.50 =========