builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0003 starttime: 1456338285.89 results: success (0) buildid: 20160224064846 builduid: 6f36bd5058924ed4a1b50460bacfd522 revision: e0cc363043ade8f69a600bfd68edaf88b35b7c96 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.887479) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.887920) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.888213) ========= 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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005412 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.912014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.912288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.929102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.929381) ========= 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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005407 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.977276) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.977558) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.977924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:45.978202) ========= 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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-24 10:24:45-- 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% 67.3M=0s 2016-02-24 10:24:46 (67.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108202 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:46.102651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:46.103161) ========= 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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.027112 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:46.151876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-24 10:24:46.152242) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e0cc363043ade8f69a600bfd68edaf88b35b7c96 --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 e0cc363043ade8f69a600bfd68edaf88b35b7c96 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-24 10:24:46,225 truncating revision to first 12 chars 2016-02-24 10:24:46,225 Setting DEBUG logging. 2016-02-24 10:24:46,226 attempt 1/10 2016-02-24 10:24:46,226 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e0cc363043ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 10:24:47,298 unpacking tar archive at: fx-team-e0cc363043ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.524530 ========= master_lag: 2.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-24 10:24:50.124079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:50.124473) ========= echo e0cc363043ade8f69a600bfd68edaf88b35b7c96 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e0cc363043ade8f69a600bfd68edaf88b35b7c96'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 e0cc363043ade8f69a600bfd68edaf88b35b7c96 program finished with exit code 0 elapsedTime=0.005872 script_repo_revision: 'e0cc363043ade8f69a600bfd68edaf88b35b7c96' ========= master_lag: 0.19 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:50.316575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:50.316906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 10:24:50.364837) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-24 10:24:50.365146) ========= /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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:24:50 INFO - MultiFileLogger online at 20160224 10:24:50 in /builds/slave/test 10:24:50 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 10:24:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:24:50 INFO - {'append_to_log': False, 10:24:50 INFO - 'base_work_dir': '/builds/slave/test', 10:24:50 INFO - 'blob_upload_branch': 'Fx-Team', 10:24:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:24:50 INFO - 'branch': 'Fx-Team', 10:24:50 INFO - 'buildbot_json_path': 'buildprops.json', 10:24:50 INFO - 'config_files': ('talos/mac_config.py',), 10:24:50 INFO - 'default_actions': ('clobber', 10:24:50 INFO - 'read-buildbot-config', 10:24:50 INFO - 'download-and-extract', 10:24:50 INFO - 'populate-webroot', 10:24:50 INFO - 'create-virtualenv', 10:24:50 INFO - 'install', 10:24:50 INFO - 'run-tests'), 10:24:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:24:50 INFO - 'download_minidump_stackwalk': True, 10:24:50 INFO - 'download_symbols': 'ondemand', 10:24:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:24:50 INFO - 'tooltool.py': '/tools/tooltool.py', 10:24:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:24:50 INFO - '/tools/misc-python/virtualenv.py')}, 10:24:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:24:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:24:50 INFO - 'installer_path': 'installer.exe', 10:24:50 INFO - 'log_level': 'info', 10:24:50 INFO - 'log_name': 'talos', 10:24:50 INFO - 'log_to_console': True, 10:24:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:24:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:24:50 INFO - 'opt_config_files': (), 10:24:50 INFO - 'pip_index': False, 10:24:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:24:50 INFO - 'cmd': ('bash', 10:24:50 INFO - '-c', 10:24:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:24:50 INFO - 'enabled': True, 10:24:50 INFO - 'halt_on_failure': False, 10:24:50 INFO - 'name': 'check_screen_resolution'},), 10:24:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:24:50 INFO - 'cmd': ('bash', 10:24:50 INFO - '-c', 10:24:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:24:50 INFO - 'enabled': True, 10:24:50 INFO - 'halt_on_failure': False, 10:24:50 INFO - 'name': 'check_screen_resolution'},), 10:24:50 INFO - 'run_cmd_checks_enabled': True, 10:24:50 INFO - 'sps_profile': False, 10:24:50 INFO - 'sps_profile_interval': 0, 10:24:50 INFO - 'suite': 'dromaeojs', 10:24:50 INFO - 'system_bits': '32', 10:24:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:24:50 INFO - 'title': 't-yosemite-r7-0003', 10:24:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:24:50 INFO - 'use_talos_json': True, 10:24:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:24:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:24:50 INFO - 'work_dir': 'build'} 10:24:50 INFO - ##### 10:24:50 INFO - ##### Running clobber step. 10:24:50 INFO - ##### 10:24:50 INFO - Running pre-action listener: _resource_record_pre_action 10:24:50 INFO - Running main action method: clobber 10:24:50 INFO - rmtree: /builds/slave/test/build 10:24:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:24:52 INFO - Running post-action listener: _resource_record_post_action 10:24:52 INFO - ##### 10:24:52 INFO - ##### Running read-buildbot-config step. 10:24:52 INFO - ##### 10:24:52 INFO - Running pre-action listener: _resource_record_pre_action 10:24:52 INFO - Running main action method: read_buildbot_config 10:24:52 INFO - Using buildbot properties: 10:24:52 INFO - { 10:24:52 INFO - "project": "", 10:24:52 INFO - "product": "firefox", 10:24:52 INFO - "script_repo_revision": "production", 10:24:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:24:52 INFO - "repository": "", 10:24:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:24:52 INFO - "buildid": "20160224064846", 10:24:52 INFO - "pgo_build": "False", 10:24:52 INFO - "basedir": "/builds/slave/test", 10:24:52 INFO - "buildnumber": 434, 10:24:52 INFO - "slavename": "t-yosemite-r7-0003", 10:24:52 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:24:52 INFO - "platform": "yosemite_r7", 10:24:52 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:24:52 INFO - "branch": "fx-team", 10:24:52 INFO - "repo_path": "integration/fx-team", 10:24:52 INFO - "revision": "e0cc363043ade8f69a600bfd68edaf88b35b7c96", 10:24:52 INFO - "stage_platform": "macosx64", 10:24:52 INFO - "builduid": "6f36bd5058924ed4a1b50460bacfd522", 10:24:52 INFO - "slavebuilddir": "test" 10:24:52 INFO - } 10:24:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:24:52 INFO - Running post-action listener: _resource_record_post_action 10:24:52 INFO - ##### 10:24:52 INFO - ##### Running download-and-extract step. 10:24:52 INFO - ##### 10:24:52 INFO - Running pre-action listener: _resource_record_pre_action 10:24:52 INFO - Running main action method: download_and_extract 10:24:52 INFO - mkdir: /builds/slave/test/build/tests 10:24:52 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')]} 10:24:52 INFO - https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/test_packages.json 10:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/test_packages.json 10:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:24:53 INFO - Downloaded 1277 bytes. 10:24:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:24:53 INFO - Using the following test package requirements: 10:24:53 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:24:53 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:24:53 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:24:53 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:24:53 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:24:53 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:24:53 INFO - u'jsshell-mac.zip'], 10:24:53 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:24:53 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:24:53 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:24:53 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:24:53 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:24:53 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:24:53 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:24:53 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:24:53 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:24:53 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:24:53 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:24:53 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:24:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:53 INFO - https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:24:55 INFO - Downloaded 17827728 bytes. 10:24:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:24:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:24:58 INFO - Return code: 0 10:24:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:24:58 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')]} 10:24:58 INFO - https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:24:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:24:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:24:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:24:59 INFO - Downloaded 17827728 bytes. 10:24:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:24:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:25:03 INFO - Return code: 0 10:25:03 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')]} 10:25:03 INFO - https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:25:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:25:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:25:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:25:04 INFO - Downloaded 10707015 bytes. 10:25:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:25:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:25:05 INFO - Return code: 0 10:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:05 INFO - https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:25:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:25:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:25:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 10:25:11 INFO - Downloaded 111449549 bytes. 10:25:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:25:11 INFO - mkdir: /builds/slave/test/properties 10:25:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:25:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:25:11 INFO - Contents: 10:25:11 INFO - build_url:https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:25:12 INFO - Running post-action listener: _resource_record_post_action 10:25:12 INFO - Running post-action listener: set_extra_try_arguments 10:25:12 INFO - ##### 10:25:12 INFO - ##### Running populate-webroot step. 10:25:12 INFO - ##### 10:25:12 INFO - Running pre-action listener: _resource_record_pre_action 10:25:12 INFO - Running main action method: populate_webroot 10:25:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:25:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:25:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:25:12 INFO - '--tppagecycles', 10:25:12 INFO - '7'], 10:25:12 INFO - 'tests': ['tsvgm']}}, 10:25:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:25:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:25:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:25:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:25:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:12 INFO - 'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:12 INFO - 'tests': ['damp', 'tps']}, 10:25:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:12 INFO - 'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['damp', 'tps']}, 10:25:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:25:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:25:12 INFO - 'other': {'tests': ['a11yr', 10:25:12 INFO - 'ts_paint', 10:25:12 INFO - 'tpaint', 10:25:12 INFO - 'sessionrestore', 10:25:12 INFO - 'sessionrestore_no_auto_restore']}, 10:25:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['a11yr', 10:25:12 INFO - 'ts_paint', 10:25:12 INFO - 'tpaint', 10:25:12 INFO - 'sessionrestore', 10:25:12 INFO - 'sessionrestore_no_auto_restore']}, 10:25:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['a11yr', 10:25:12 INFO - 'ts_paint', 10:25:12 INFO - 'tpaint', 10:25:12 INFO - 'sessionrestore', 10:25:12 INFO - 'sessionrestore_no_auto_restore']}, 10:25:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['a11yr', 10:25:12 INFO - 'ts_paint', 10:25:12 INFO - 'tpaint', 10:25:12 INFO - 'sessionrestore', 10:25:12 INFO - 'sessionrestore_no_auto_restore']}, 10:25:12 INFO - 'other_l64': {'tests': ['a11yr', 10:25:12 INFO - 'ts_paint', 10:25:12 INFO - 'tpaint', 10:25:12 INFO - 'sessionrestore', 10:25:12 INFO - 'sessionrestore_no_auto_restore']}, 10:25:12 INFO - 'other_nol64': {'tests': ['a11yr', 10:25:12 INFO - 'ts_paint', 10:25:12 INFO - 'tpaint', 10:25:12 INFO - 'sessionrestore', 10:25:12 INFO - 'sessionrestore_no_auto_restore']}, 10:25:12 INFO - 'svgr': {'tests': ['tsvgx', 10:25:12 INFO - 'tsvgr_opacity', 10:25:12 INFO - 'tart', 10:25:12 INFO - 'tscrollx', 10:25:12 INFO - 'cart']}, 10:25:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['tsvgx', 10:25:12 INFO - 'tsvgr_opacity', 10:25:12 INFO - 'tart', 10:25:12 INFO - 'tscrollx', 10:25:12 INFO - 'cart']}, 10:25:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:12 INFO - 'tests': ['tp5o']}, 10:25:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:12 INFO - 'talos_options': ['--e10s'], 10:25:12 INFO - 'tests': ['tp5o']}, 10:25:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:12 INFO - 'talos_options': ['--xperf_path', 10:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:12 INFO - 'tests': ['tp5n']}, 10:25:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:12 INFO - 'talos_options': ['--e10s', 10:25:12 INFO - '--xperf_path', 10:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:12 INFO - 'tests': ['tp5n']}}, 10:25:12 INFO - 'talos.zip': {'path': '', 10:25:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:25:12 INFO - Running post-action listener: _resource_record_post_action 10:25:12 INFO - ##### 10:25:12 INFO - ##### Running create-virtualenv step. 10:25:12 INFO - ##### 10:25:12 INFO - Running pre-action listener: _resource_record_pre_action 10:25:12 INFO - Running main action method: create_virtualenv 10:25:12 INFO - Creating virtualenv /builds/slave/test/build/venv 10:25:12 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 10:25:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:25:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:25:12 INFO - Using real prefix '/tools/python27' 10:25:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:25:13 INFO - Installing distribute.............................................................................................................................................................................................done. 10:25:16 INFO - Installing pip.................done. 10:25:16 INFO - Return code: 0 10:25:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:25:16 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')]} 10:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:16 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')]} 10:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:16 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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:16 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 10:25:16 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 10:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:16 INFO - 'HOME': '/Users/cltbld', 10:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:16 INFO - 'LOGNAME': 'cltbld', 10:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:16 INFO - 'MOZ_NO_REMOTE': '1', 10:25:16 INFO - 'NO_EM_RESTART': '1', 10:25:16 INFO - 'PAGER': '/bin/cat', 10:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:16 INFO - 'PWD': '/builds/slave/test', 10:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:16 INFO - 'SHELL': '/bin/bash', 10:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:16 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:16 INFO - 'USER': 'cltbld', 10:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:16 INFO - 'XPC_FLAGS': '0x0', 10:25:16 INFO - 'XPC_SERVICE_NAME': '0', 10:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:16 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 10:25:16 INFO - Cleaning up... 10:25:16 INFO - Return code: 0 10:25:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:25:16 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')]} 10:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:16 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')]} 10:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:16 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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:16 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 10:25:16 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 10:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:16 INFO - 'HOME': '/Users/cltbld', 10:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:16 INFO - 'LOGNAME': 'cltbld', 10:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:16 INFO - 'MOZ_NO_REMOTE': '1', 10:25:16 INFO - 'NO_EM_RESTART': '1', 10:25:16 INFO - 'PAGER': '/bin/cat', 10:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:16 INFO - 'PWD': '/builds/slave/test', 10:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:16 INFO - 'SHELL': '/bin/bash', 10:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:16 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:16 INFO - 'USER': 'cltbld', 10:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:16 INFO - 'XPC_FLAGS': '0x0', 10:25:16 INFO - 'XPC_SERVICE_NAME': '0', 10:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:16 INFO - Downloading/unpacking psutil>=0.7.1 10:25:16 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 10:25:16 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 10:25:16 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 10:25:16 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 10:25:16 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 10:25:16 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 10:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:25:19 INFO - Installing collected packages: psutil 10:25:19 INFO - Running setup.py install for psutil 10:25:19 INFO - building 'psutil._psutil_osx' extension 10:25:19 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 10:25:20 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 10:25:20 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 10:25:20 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 10:25:20 INFO - building 'psutil._psutil_posix' extension 10:25:20 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 10:25:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:25:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:25:20 INFO - ^ 10:25:20 INFO - 1 warning generated. 10:25:20 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 10:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:25:20 INFO - Successfully installed psutil 10:25:20 INFO - Cleaning up... 10:25:20 INFO - Return code: 0 10:25:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:25:20 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')]} 10:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:20 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')]} 10:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:20 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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:20 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 10:25:20 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 10:25:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:20 INFO - 'HOME': '/Users/cltbld', 10:25:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:20 INFO - 'LOGNAME': 'cltbld', 10:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:20 INFO - 'MOZ_NO_REMOTE': '1', 10:25:20 INFO - 'NO_EM_RESTART': '1', 10:25:20 INFO - 'PAGER': '/bin/cat', 10:25:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:20 INFO - 'PWD': '/builds/slave/test', 10:25:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:20 INFO - 'SHELL': '/bin/bash', 10:25:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:20 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:20 INFO - 'USER': 'cltbld', 10:25:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:20 INFO - 'XPC_FLAGS': '0x0', 10:25:20 INFO - 'XPC_SERVICE_NAME': '0', 10:25:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:25:21 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 10:25:21 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 10:25:21 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 10:25:21 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 10:25:21 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 10:25:21 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 10:25:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:25:23 INFO - Installing collected packages: mozsystemmonitor 10:25:23 INFO - Running setup.py install for mozsystemmonitor 10:25:23 INFO - Successfully installed mozsystemmonitor 10:25:23 INFO - Cleaning up... 10:25:23 INFO - Return code: 0 10:25:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:23 INFO - 'HOME': '/Users/cltbld', 10:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:23 INFO - 'LOGNAME': 'cltbld', 10:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:23 INFO - 'MOZ_NO_REMOTE': '1', 10:25:23 INFO - 'NO_EM_RESTART': '1', 10:25:23 INFO - 'PAGER': '/bin/cat', 10:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:23 INFO - 'PWD': '/builds/slave/test', 10:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:23 INFO - 'SHELL': '/bin/bash', 10:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:23 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:23 INFO - 'USER': 'cltbld', 10:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:23 INFO - 'XPC_FLAGS': '0x0', 10:25:23 INFO - 'XPC_SERVICE_NAME': '0', 10:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:25:23 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 10:25:23 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 10:25:23 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 10:25:23 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 10:25:23 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 10:25:23 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 10:25:26 INFO - Downloading blobuploader-1.2.4.tar.gz 10:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:25:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:25:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:27 INFO - Downloading docopt-0.6.1.tar.gz 10:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:25:27 INFO - Installing collected packages: blobuploader, requests, docopt 10:25:27 INFO - Running setup.py install for blobuploader 10:25:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:25:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:25:27 INFO - Running setup.py install for requests 10:25:28 INFO - Running setup.py install for docopt 10:25:28 INFO - Successfully installed blobuploader requests docopt 10:25:28 INFO - Cleaning up... 10:25:28 INFO - Return code: 0 10:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:28 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')]} 10:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:28 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')]} 10:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:28 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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:28 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 10:25:28 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 10:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:28 INFO - 'HOME': '/Users/cltbld', 10:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:28 INFO - 'LOGNAME': 'cltbld', 10:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:28 INFO - 'MOZ_NO_REMOTE': '1', 10:25:28 INFO - 'NO_EM_RESTART': '1', 10:25:28 INFO - 'PAGER': '/bin/cat', 10:25:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:28 INFO - 'PWD': '/builds/slave/test', 10:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:28 INFO - 'SHELL': '/bin/bash', 10:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:28 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:28 INFO - 'USER': 'cltbld', 10:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:28 INFO - 'XPC_FLAGS': '0x0', 10:25:28 INFO - 'XPC_SERVICE_NAME': '0', 10:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-HM5k3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-lvbHdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-3VvuTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-s4N7W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-m3mvFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-J2GJew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-TQpytu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-n17x6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-xMlwVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Iy8tEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-C_E2A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-S515Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:30 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-rmRpwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:30 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-qMIBqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:30 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-j0Hrd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:30 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-mNrvSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:30 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-9RiiNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:25:30 INFO - Running setup.py install for manifestparser 10:25:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:25:30 INFO - Running setup.py install for mozcrash 10:25:30 INFO - Running setup.py install for mozdebug 10:25:31 INFO - Running setup.py install for mozdevice 10:25:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:25:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:25:31 INFO - Running setup.py install for mozfile 10:25:31 INFO - Running setup.py install for mozhttpd 10:25:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:25:31 INFO - Running setup.py install for mozinfo 10:25:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:25:31 INFO - Running setup.py install for mozInstall 10:25:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:25:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:25:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:25:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:25:31 INFO - Running setup.py install for mozleak 10:25:31 INFO - Running setup.py install for mozlog 10:25:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:25:32 INFO - Running setup.py install for moznetwork 10:25:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:25:32 INFO - Running setup.py install for mozprocess 10:25:32 INFO - Running setup.py install for mozprofile 10:25:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:25:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:25:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:25:32 INFO - Running setup.py install for mozrunner 10:25:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:25:32 INFO - Running setup.py install for mozscreenshot 10:25:32 INFO - Running setup.py install for moztest 10:25:33 INFO - Running setup.py install for mozversion 10:25:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:25:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:25:33 INFO - Cleaning up... 10:25:33 INFO - Return code: 0 10:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:33 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')]} 10:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:33 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')]} 10:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:33 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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:33 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 10:25:33 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 10:25:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:33 INFO - 'HOME': '/Users/cltbld', 10:25:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:33 INFO - 'LOGNAME': 'cltbld', 10:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:33 INFO - 'MOZ_NO_REMOTE': '1', 10:25:33 INFO - 'NO_EM_RESTART': '1', 10:25:33 INFO - 'PAGER': '/bin/cat', 10:25:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:33 INFO - 'PWD': '/builds/slave/test', 10:25:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:33 INFO - 'SHELL': '/bin/bash', 10:25:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:33 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:33 INFO - 'USER': 'cltbld', 10:25:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:33 INFO - 'XPC_FLAGS': '0x0', 10:25:33 INFO - 'XPC_SERVICE_NAME': '0', 10:25:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:33 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-bipi_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:33 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)) 10:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:33 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Xfoaql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:33 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-efPGxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:33 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)) 10:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:33 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-zmph0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:33 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)) 10:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:33 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-LRaGVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-YuBj_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-f_VfTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-hnzEFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-idCWtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-DiudCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-xg_evi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-lY78Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-hPzkau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-ilHpzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:34 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)) 10:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:34 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-qryD0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:35 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)) 10:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:35 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Gi_bAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:35 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)) 10:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:35 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-aHELgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:35 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)) 10:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:35 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)) 10:25:35 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)) 10:25:35 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)) 10:25:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:25:35 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 10:25:35 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 10:25:35 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 10:25:35 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 10:25:35 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 10:25:35 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 10:25:37 INFO - Downloading blessings-1.6.tar.gz 10:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:25:37 INFO - Installing collected packages: blessings 10:25:37 INFO - Running setup.py install for blessings 10:25:37 INFO - Successfully installed blessings 10:25:37 INFO - Cleaning up... 10:25:38 INFO - Return code: 0 10:25:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:25:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:38 INFO - Reading from file tmpfile_stdout 10:25:38 INFO - Current package versions: 10:25:38 INFO - blessings == 1.6 10:25:38 INFO - blobuploader == 1.2.4 10:25:38 INFO - docopt == 0.6.1 10:25:38 INFO - manifestparser == 1.1 10:25:38 INFO - mozInstall == 1.12 10:25:38 INFO - mozcrash == 0.16 10:25:38 INFO - mozdebug == 0.1 10:25:38 INFO - mozdevice == 0.48 10:25:38 INFO - mozfile == 1.2 10:25:38 INFO - mozhttpd == 0.7 10:25:38 INFO - mozinfo == 0.9 10:25:38 INFO - mozleak == 0.1 10:25:38 INFO - mozlog == 3.1 10:25:38 INFO - moznetwork == 0.27 10:25:38 INFO - mozprocess == 0.22 10:25:38 INFO - mozprofile == 0.28 10:25:38 INFO - mozrunner == 6.11 10:25:38 INFO - mozscreenshot == 0.1 10:25:38 INFO - mozsystemmonitor == 0.0 10:25:38 INFO - moztest == 0.7 10:25:38 INFO - mozversion == 1.4 10:25:38 INFO - psutil == 3.1.1 10:25:38 INFO - requests == 1.2.3 10:25:38 INFO - wsgiref == 0.1.2 10:25:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:38 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')]} 10:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:38 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')]} 10:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:38 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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:38 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 10:25:38 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 10:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:38 INFO - 'HOME': '/Users/cltbld', 10:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:38 INFO - 'LOGNAME': 'cltbld', 10:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:38 INFO - 'MOZ_NO_REMOTE': '1', 10:25:38 INFO - 'NO_EM_RESTART': '1', 10:25:38 INFO - 'PAGER': '/bin/cat', 10:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:38 INFO - 'PWD': '/builds/slave/test', 10:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:38 INFO - 'SHELL': '/bin/bash', 10:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:38 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:38 INFO - 'USER': 'cltbld', 10:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:38 INFO - 'XPC_FLAGS': '0x0', 10:25:38 INFO - 'XPC_SERVICE_NAME': '0', 10:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 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)) 10:25:38 INFO - Cleaning up... 10:25:38 INFO - Return code: 0 10:25:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:25:38 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')]} 10:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:38 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')]} 10:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:38 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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:38 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 10:25:38 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 10:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:38 INFO - 'HOME': '/Users/cltbld', 10:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:38 INFO - 'LOGNAME': 'cltbld', 10:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:38 INFO - 'MOZ_NO_REMOTE': '1', 10:25:38 INFO - 'NO_EM_RESTART': '1', 10:25:38 INFO - 'PAGER': '/bin/cat', 10:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:38 INFO - 'PWD': '/builds/slave/test', 10:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:38 INFO - 'SHELL': '/bin/bash', 10:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:38 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:38 INFO - 'USER': 'cltbld', 10:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:38 INFO - 'XPC_FLAGS': '0x0', 10:25:38 INFO - 'XPC_SERVICE_NAME': '0', 10:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:38 INFO - Downloading/unpacking jsonschema 10:25:38 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 10:25:38 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 10:25:38 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 10:25:38 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 10:25:38 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 10:25:38 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 10:25:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:25:41 INFO - Downloading/unpacking functools32 (from jsonschema) 10:25:41 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 10:25:41 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 10:25:41 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 10:25:41 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 10:25:41 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 10:25:41 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 10:25:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:25:41 INFO - warning: no files found matching '*.txt' 10:25:41 INFO - no previously-included directories found matching 'build' 10:25:41 INFO - no previously-included directories found matching 'dist' 10:25:41 INFO - no previously-included directories found matching '.git*' 10:25:41 INFO - Installing collected packages: jsonschema, functools32 10:25:41 INFO - Running setup.py install for functools32 10:25:41 INFO - warning: no files found matching '*.txt' 10:25:41 INFO - no previously-included directories found matching 'build' 10:25:41 INFO - no previously-included directories found matching 'dist' 10:25:41 INFO - no previously-included directories found matching '.git*' 10:25:42 INFO - Successfully installed jsonschema functools32 10:25:42 INFO - Cleaning up... 10:25:42 INFO - Return code: 0 10:25:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:42 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 0x1065b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa634cee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, '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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 10:25:42 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 10:25:42 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 10:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:42 INFO - 'HOME': '/Users/cltbld', 10:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:42 INFO - 'LOGNAME': 'cltbld', 10:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:42 INFO - 'MOZ_NO_REMOTE': '1', 10:25:42 INFO - 'NO_EM_RESTART': '1', 10:25:42 INFO - 'PAGER': '/bin/cat', 10:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:42 INFO - 'PWD': '/builds/slave/test', 10:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:42 INFO - 'SHELL': '/bin/bash', 10:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:25:42 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:42 INFO - 'USER': 'cltbld', 10:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:42 INFO - 'XPC_FLAGS': '0x0', 10:25:42 INFO - 'XPC_SERVICE_NAME': '0', 10:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:42 INFO - Downloading/unpacking flake8 10:25:42 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 10:25:42 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 10:25:42 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 10:25:42 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 10:25:42 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 10:25:42 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 10:25:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:25:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:25:45 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 10:25:45 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 10:25:45 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 10:25:45 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 10:25:45 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 10:25:45 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 10:25:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:25:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:25:45 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 10:25:45 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 10:25:45 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 10:25:45 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 10:25:45 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 10:25:45 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 10:25:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:25: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 10:25: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 10:25: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 10:25: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 10:25: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 10:25: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 10:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:25:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:25:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:25:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:25:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:25:46 INFO - no previously-included directories found matching 'docs/_build' 10:25:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:25:46 INFO - Running setup.py install for pep8 10:25:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:25:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:25:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:25:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:25:46 INFO - no previously-included directories found matching 'docs/_build' 10:25:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:25:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:25:46 INFO - Cleaning up... 10:25:47 INFO - Return code: 0 10:25:47 INFO - Running post-action listener: _resource_record_post_action 10:25:47 INFO - Running post-action listener: _start_resource_monitoring 10:25:47 INFO - Starting resource monitoring. 10:25:47 INFO - ##### 10:25:47 INFO - ##### Running install step. 10:25:47 INFO - ##### 10:25:47 INFO - Running pre-action listener: _resource_record_pre_action 10:25:47 INFO - Running main action method: install 10:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:47 INFO - Reading from file tmpfile_stdout 10:25:47 INFO - Detecting whether we're running mozinstall >=1.0... 10:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:25:47 INFO - Reading from file tmpfile_stdout 10:25:47 INFO - Output received: 10:25:47 INFO - Usage: mozinstall [options] installer 10:25:47 INFO - Options: 10:25:47 INFO - -h, --help show this help message and exit 10:25:47 INFO - -d DEST, --destination=DEST 10:25:47 INFO - Directory to install application into. [default: 10:25:47 INFO - "/builds/slave/test"] 10:25:47 INFO - --app=APP Application being installed. [default: firefox] 10:25:47 INFO - mkdir: /builds/slave/test/build/application 10:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:26:22 INFO - Reading from file tmpfile_stdout 10:26:22 INFO - Output received: 10:26:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:26:22 INFO - Running post-action listener: _resource_record_post_action 10:26:22 INFO - ##### 10:26:22 INFO - ##### Running run-tests step. 10:26:22 INFO - ##### 10:26:22 INFO - Running pre-action listener: _resource_record_pre_action 10:26:22 INFO - Running main action method: run_tests 10:26:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:26:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:26:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:26:22 INFO - 2016-02-24 10:26:22.318 screenresolution[1650:7552] starting screenresolution argv=screenresolution get 10:26:22 INFO - 2016-02-24 10:26:22.321 screenresolution[1650:7552] Display 0: 1600x1200x32@60 10:26:22 INFO - 2016-02-24 10:26:22.327 screenresolution[1651:7554] starting screenresolution argv=screenresolution list 10:26:22 INFO - Available Modes on Display 0 10:26:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:26:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:26:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:26:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:26:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:26:22 INFO - Intel Iris: 10:26:22 INFO - Chipset Model: Intel Iris 10:26:22 INFO - Type: GPU 10:26:22 INFO - Bus: Built-In 10:26:22 INFO - VRAM (Dynamic, Max): 1536 MB 10:26:22 INFO - Vendor: Intel (0x8086) 10:26:22 INFO - Device ID: 0x0a2e 10:26:22 INFO - Revision ID: 0x0009 10:26:22 INFO - Displays: 10:26:22 INFO - Display: 10:26:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:26:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:26:22 INFO - Display Serial Number: 1600x1200 60 10:26:22 INFO - Main Display: Yes 10:26:22 INFO - Mirror: Off 10:26:22 INFO - Online: Yes 10:26:22 INFO - Rotation: Supported 10:26:22 INFO - Return code: 0 10:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:26:22 INFO - Python 2.7.3 10:26:22 INFO - Return code: 0 10:26:22 INFO - grabbing minidump binary from tooltool 10:26:22 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')]} 10:26:22 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 0x106457d30>, '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 0x10627bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10644eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:26:22 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 10:26:22 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 10:26:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:26:22 INFO - Return code: 0 10:26:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:26:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:26:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:26:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:26:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:26:23 INFO - Return code: 0 10:26:23 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/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 10:26:23 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/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0003 --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 10:26:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AtNA5gnmQQ/Render', 10:26:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:23 INFO - 'HOME': '/Users/cltbld', 10:26:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:23 INFO - 'LOGNAME': 'cltbld', 10:26:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:26:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:23 INFO - 'MOZ_NO_REMOTE': '1', 10:26:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:26:23 INFO - 'NO_EM_RESTART': '1', 10:26:23 INFO - 'PAGER': '/bin/cat', 10:26:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:23 INFO - 'PWD': '/builds/slave/test', 10:26:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:26:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:23 INFO - 'SHELL': '/bin/bash', 10:26:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VkUs4yCIdU/Listeners', 10:26:23 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 10:26:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:23 INFO - 'USER': 'cltbld', 10:26:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:23 INFO - 'XPC_FLAGS': '0x0', 10:26:23 INFO - 'XPC_SERVICE_NAME': '0', 10:26:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:23 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/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 10:26:24 INFO - mozversion application_buildid: 20160224064846 10:26:24 INFO - mozversion application_changeset: e0cc363043ade8f69a600bfd68edaf88b35b7c96 10:26:24 INFO - mozversion application_display_name: Nightly 10:26:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:26:24 INFO - mozversion application_name: Firefox 10:26:24 INFO - mozversion application_remotingname: firefox 10:26:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:26:24 INFO - mozversion application_vendor: Mozilla 10:26:24 INFO - mozversion application_version: 47.0a1 10:26:24 INFO - mozversion platform_buildid: 20160224064846 10:26:24 INFO - mozversion platform_changeset: e0cc363043ade8f69a600bfd68edaf88b35b7c96 10:26:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:26:24 INFO - mozversion platform_version: 47.0a1 10:26:24 INFO - using testdate: 1456338384 10:26:24 INFO - actual date: 1456338384 10:26:24 INFO - starting webserver on 'localhost:49283' 10:26:24 INFO - SUITE-START | Running 2 tests 10:26:24 INFO - TEST-START | dromaeo_css 10:26:24 INFO - operating with platform_type : mac_ 10:26:24 INFO - Initialising browser for dromaeo_css test... 10:26:24 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpJbQDkV/profile http://localhost:49283/getInfo.html) 10:26:26 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 10:26:26 INFO - PROCESS | 1669 | colorDepth:24 10:26:26 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 10:26:26 INFO - PROCESS | 1669 | __metrics 10:26:27 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:26:27 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:26:27 INFO - TEST-INFO | 1669: exit 0 10:26:27 INFO - Browser initialized. 10:26:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:26:27 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpJbQDkV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:39 INFO - PROCESS | 1672 | RSS: Main: 244293632 10:26:39 INFO - PROCESS | 1672 | 10:27:30 INFO - PROCESS | 1672 | 1456338450843 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] 10:29:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 10:29:42 INFO - PROCESS | 1672 | RSS: Main: 362434560 10:29:42 INFO - PROCESS | 1672 | 10:32:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 10:32:45 INFO - PROCESS | 1672 | RSS: Main: 377008128 10:32:45 INFO - PROCESS | 1672 | 10:35:47 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 10:35:48 INFO - PROCESS | 1672 | RSS: Main: 376283136 10:35:48 INFO - PROCESS | 1672 | 10:38:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 10:38:51 INFO - PROCESS | 1672 | RSS: Main: 334331904 10:38:51 INFO - PROCESS | 1672 | 10:41:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 10:41:54 INFO - PROCESS | 1672 | RSS: Main: 339419136 10:41:54 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 10:44:57 INFO - PROCESS | 1672 | RSS: Main: 385871872 10:44:57 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | __start_tp_report 10:44:57 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 10:44:57 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 10:44:57 INFO - PROCESS | 1672 | |i|pagename|runs| 10:44:57 INFO - PROCESS | 1672 | |0;dojo.html;3206.807591544507;3483.5471388719448;3501.8249087545614;3508.052825737051;3561.216532362879;5518.144687573433;5574.554035677146;5618.887622247553;5621.943780562193;5637.379888212298;5596.4403559644015;5620.859478513039;5669.971650141754;5774.6535207887455;5839.474447299742;5042.873928151789;5064.417591976933;5065.974670126644;5077.720725360104;5235.476452354753;5219.217117432397;5219.660722053073;5235.240890070937;5288.867778305554;5294.364676238857;5059.367579052619;5098.031374038921;5153.046686363016;5181.81863634771;5217.295665085203;5128.974205158946;5135.974320128375;5153.922691159635;5159.71621560814;5173;5105.361829771278;5125.820596279113;5143.537081662668;5174.146265866128;5185;5477.1510415885605;5544.140658197985;5605.579581531401;5634.4365563443735;5665.943340566583;6163.291221509539;6168.629882207037;6172.567920245585;6182.783602573933;6191.783287584958;6210.627362358227;6242.625442473466;6250.6874656267455;6258.9374106259265;6276.435120839146;5603.80386686464;5678.574106942037;5707.857303567444;5721.713914304351;5777.0467872801355;6266.185395898504;6280.214973128359;6291.559590828598;6295.527835412271;6331.113644089831;5863.442972917566;6043.637381757108;6048.485878700271;6097;6115.663638499836;6132.04958718918;6138.909559458743;6237.563370564017;6237.656928868865;6257.186565746424;6131.816045518642;6141.539384546177;6163.876722465526;6171.228596425447;6186.505079593621;6051.122587224828;6136.54971344134;6182.536309776785;6186.907196392058;6193.6903154842075;4843.878903027382;4853.733044682576;4873.805047798049;4875.488073752205;4910.435299940553;4326.870193894189;4338.132373525307;4354.912901741947;4359.280718681445;4388.626966707801;5563.082091454946;5650;5678.233438485834;5706.087026075808;5711.885762284731;5127.4872512748425;6193.040078787795;6196.3803619638575;6198.535109866778;6240.00159974402;5678.119891416837;5684.289463817023;5686.317641882918;5692.430756924357;5696.658200507983;5208;5213.895722085537;5298.97350513245;5310.92033619496;5314.627976041717;6284.968575157095;6293.244810622755;6307.400796924285;6311.463525600376;6337.239531256187;6148.754049838135;6171.814845554641;6201.131841542278;6267.1539342188225;6287.119803227461;6215.906761398673;6257.405546473078;6272.153259309935;6274.780382686584;6283.96858015707;5057.443681194992;6043.456088952015;6107.328193898757;6126.632402055891;6141.232345956755;6125.235451818428;6129.358790882775;6236.469900058546;6259.874802504016;6268.059791031382;4698.436187657503;5025.6482046256415;5255.632105752714;6032.939670603413;6051.031834906394;5845.064789633639;5964.254468191476;5974.731137098754;5995.880082398415;6001.159837622649;5812.21535092774;5838.708064596668;5839.883202336015;5844.707764611838;5855.23881895368;5960.802964548399;5981.790637327673;6019.157317975574;6090.299615544269;6095.238095238095;5277.1292736698015;5882.558808089325;5898.144769008555;5942.821715348547;5957.374475680164 10:44:57 INFO - PROCESS | 1672 | |1;ext.html;461.4600916927193;543.6411968101054;557.4007941462926;586.7799575159315;591.4794980417232;36427.63572364276;36624;36740.816295918485;36743.4488482673;36788;37539.436908446325;38034.61965380346;38042.0489487763;38079.80960095196;38102.23795524088;9254.44473331599;9475.47884866332;9484.241260699162;9491.620335186584;9502.80994380112;9365.67220147295;9616.759581010496;9618.711438656817;9628.47043412612;9648.565814538362;9568.617255309815;9646.180074693659;9649.662261820838;9651.276154288422;9667.178289845371;9557.952210238938;9628.3260171788;9638.662646807397;9645.565949532287;9668.806623867553;9410.952945235298;9544.904550954541;9563.952180239125;9572.042795720441;9582.808343833154;37064.258714825824;37275.62724372749;37387.25225495502;37395.25209495822;37455.81272093649;2599.805014623892;3033.423649506609;3088.9299241953117;3128.436881361354;3328.517364982088;24008.759912400827;27488.725112748816;27722.5841612376;28344.858275708695;29087.41825163506;2725.68654604721;2770.9307267318277;2839.7302256285825;2852.472292625871;2938.6326709161353;395997;470148;471324;471604.6419767914;472091.9535632507;52624;53656.73171634117;59203.407965920655;60101.39898600958;60123.39876601178;49776.25335619968;50045.9990800182;50165.49834501608;62624.68687656624;63645.68177159177;15868.44460443879;16096.275667594986;16187.838121618634;16259.187040647921;16259.918700406422;12423.068269879795;12531.937340313423;12537.937310313573;12547.560835370901;12578.182418142791;16495.670086598202;18403.079846007648;18889.244430222636;18901.43295701131;19076.33232836844;8126.878096828552;8322.20939010793;8352.791180220422;8438.789030274169;8464.407491475538;959.4195511715312;976.9755756106155;984.9753756156153;1008.3143462445461;1018.1193267823279;28523.857380712965;28647.856760716062;28730.138095857157;29140.9800656976;29183.41633167325;1076.9623063192907;1097.2757979733337;1114.5430373546808;1168.655246702225;1205.1925210109248;12414.81377779334;14348.70861622459;14596.861674739981;14678.89908256885;14912.552623421314;511405;524317;528277;529390;529567;56029.719851400485;56097.878042438926;56177.43822561722;56188.34775739564;56290.718546407006;1402.2287741742205;1424.77203647418;1442.6032840968608;1443.2422977936667;1443.2999995002415;27125.59311610288;27928.720712793423;28824.567631485963;28842.855785720938;29632.851835740683;46001.53998460106;49354.259686105455;49945.25082123699;51651;52571.42285731434;329943;333371.6662833341;336720.31639842625;336725;336852;29951.251218719706;30335.696643033287;30371.088867334016;30401.239969000068;30403.2399190022;34698.826505867306;41683.58316416797;42656.36015459709;43113.13773724571;43800.780996094814;33117.83441082779;33473.15897625654;34101.82949085239;34159.829200853834;35634;29846.55230171506;33054.843080492064;33669.32661346808;33680.49479257862;33695;33666;35451.46822797608;35775.46336804898;35858.51768528934;35877.1030724234;28147.014854479996;30267.848660756554;30310.427116357045;30394.544081838347;30509.71177161766;23498.530029398975;23519.52960940806;23818;23900.28299151028;23943 10:44:57 INFO - PROCESS | 1672 | |2;jquery.html;305.2247291878628;358.1368900948713;360.0656296909519;361.1548975397569;366.27112047026424;15681.607959800982;16178.514644560653;18967.905160474194;19392.41822745318;20509.282175123873;15328.080315181069;16258.593535161626;19397.4180774577;19435.222591096375;19455.513612159702;5601.187827764982;5619.185218143367;5821.67980761058;5829.5919285650025;5845.503132233765;3872.554656214529;5665.603407761459;5785;5800.100984347433;5805.73874175661;5652.689102099383;5893.675847828367;5907.468327850493;5910.172575839386;5914;5809.244798176232;5870;5890.793822216223;5902.527797776168;6263.874722505524;5601.411851755588;5652.9152062719095;5655.293088363955;5661.065924122515;5670.092785154356;12666.176698514659;12861.485540578366;19879.60240795176;25083.12209072692;25151.119710810217;2105.947351316214;2286.142696488817;2344.2732752846673;2660.5743081107125;2745.917622471329;9703.563339649732;9719.514024298756;10207.489625518769;12873.87126128736;13958.255218097738;1680.8991460512286;1746.8777185597014;1764.1091248919213;1817.6092140189924;1841.6040551281405;77511;77561;89542.5522872388;106649.46675266574;114329.28506072416;10292;11156;11223.438828058564;11292.322460652387;11332.3935494835;13413.463461461432;13477.393517291745;13515.797263041062;13549.661258468617;13555.186688798703;8515.787105322293;8527.360447966303;8529.402941794138;8548.444351117158;8621.62054071358;8727;8733.301335893113;8734.126587341216;8753.64985400577;8801.25189358899;4393.670474714345;4419.40338054365;4419.513853476115;4426.0926510066;4454.443194600675;1791.4625612316513;1859.4700510354485;1863.5993261448582;1865.703336181368;1866.57068874157;841.2765022081005;868.934829887761;896.5338024227365;945.9574319155516;977.8337682593976;19527.511812204808;19691.50771230702;19998.800011999694;20248.797512024987;20276.89861550712;792.5482474989316;897.9449147251953;926.6571368593663;954.6491714224434;971.1308379000754;6164.568480206342;6209.472194863487;6213.099100630474;6235.095911092957;10613.5223914924;405880;409436;409549;520677;637766;93737;99125;120711;121446.3927680356;125403;462.82875336125846;468.7726452670452;473.3822361817792;474.4567470246548;477.01020382706025;8930.508822014852;9625.51872406363;11333.489992950172;11364.659060228207;11593.420328983686;39788.6073987409;44105.338419923086;49788;50804.49195508145;52253.59435301682;68319.65840170767;70318;70761.64619177076;71457.64271178818;71567;7937.484063535851;8021.2379823916635;8073.3541316693345;8141.51150930946;8391.790205244673;9512.38169518979;13298.601041968757;13434.596962091153;13536.187828730308;13679.31603419845;11527.8270825936;11753.412329383325;11770.823437648613;11790.587329443428;11806.763864722829;5589.80435684749;10344.948275258877;11084.61203857861;11425.657230283105;11674.299542027506;11849.881501184878;11899.583514576949;11901.766668489827;11954.163208575315;11972.461239244081;6270.561060725706;7382.778516644509;8207.138250483853;8393.916060839314;8395.832083358177;10364.326318789555;11876.346800926032;12003.579874704343;12035.518579256732;12056.336901470153 10:44:57 INFO - PROCESS | 1672 | |3;mootools.html;1224.6999485126144;1375.77299745542;1517.6812869297446;1693.6358682883185;1949.2885096939622;7589.051368578927;8171.284030353626;8343.707970221043;8366.121557236478;8404.789880252989;8061.113277539481;8344.582770861463;8362.03836558796;8362.581870906446;8368.958155209231;2116.9788302117013;2178.4336072621154;2182.8144607708364;2386.630072338786;2420.987895060522;2383.1420688552107;2449.3141920262356;2449.632555116729;2452.141750387359;2454.361865914857;2359.2096647623066;2398.70016247969;2407.8675672837985;2411.553862535428;2415.516896620683;2372.240882917467;2383.761623837611;2386.164842305188;2398.3764221302413;2412.3486658602255;2394.592919203722;2396.8801559921935;2399.2682231919257;2399.472116134448;2407.8201681176274;8421.326293896534;8490.320774338039;8497.745067647918;8510.191531804468;8512.659493620247;5192.1173400522;5371.113766228567;5372.247885296062;5376.946230537723;5379.65032272905;3535.4520049392386;3571.964280357189;3620.8551657933913;3664.5785734640326;3667.8716244931566;1027.1525991057333;1046.1055797293282;1059.2276547511824;1061.0927656853435;1077.520503375998;11044.502997365138;11204.607838725688;11236.49435775384;11236.988671019566;11252.26860254081;4321.962728945031;4398.428204333481;4724.95275047252;4780.976095119502;4789.640776941744;9626.711198664052;9632.121736261362;9657;9664;9671;5276.050310943991;5306.7611957462;5322.574194064543;5336.519713225751;5345.866353341197;4294.634956028773;4460.710053846489;4678.391809064799;4817.494163112823;4858.6356023298395;3798.8290526926353;3817.6564109230303;3817.828197731109;3856.382978723391;3868.052327179859;1264.5384434681275;1272.516443751387;1275.6683262351855;1288.4395288049727;1289.4519829072606;1099.8900109989097;1113.9665810025713;1114.5207560748956;1255.8116282557507;1349.6558377613646;7788.883166752503;7857.882131768028;7891.368690504746;7914;7918.287354138155;502.2992924869859;514.5343464164937;518.1528201390678;518.2795913679988;521.5097808060411;6000.429959153874;6058.000429929012;6075.301340345828;6077.3314935357075;6088.695565221721;9841.50792460374;10049.447280399501;10097.24270679702;10140.239482038876;10191.490425478696;8980.8652870207;9942.900570994341;10005.149562287286;10047.145992590566;10071.942446043207;7452.813679657944;7885.093214280431;7899.170587088273;7907.209279072047;7983.161768014391;7670.7315243966195;7674;7776.222377762178;7776.727814526691;7879.487833290817;9056.592453339746;9343.813123737624;9347.532623368668;9445.913719922297;9464.479453630116;7928.920710792819;9557.522123893916;9557.665481708107;9569.712908612753;9854.605815767576;5900.203472531153;6613.074169616161;6795.25252222265;7222.855542889218;7364.263573642593;7916.050073991158;7922.247386498273;7975.840483190188;7984.121746607984;8010.439269251096;6960.4779641526075;7048;7082.645867706491;7179.353858152583;7183.5330703504105;6951.826204344729;6977.406920411822;7031.332023457763;7054.788356349318;7109.502334836719;7336.559806411419;7407.555546667218;7507.136679281734;7534.284242996907;7569.091708994735;6779.661016949034;6789.694463749044;6842.144731908512;6857.965710171417;6869.828254293682;6911.7926462206215;6938.469983532032;6942.166939967236;6983.720651173896;6989.161300643956 10:44:57 INFO - PROCESS | 1672 | |4;prototype.html;313.7129526483268;321.1761830903732;324.84569829331065;329.1097581043278;331.9834008299587;6634.767783127591;6645.86708265835;6659.334066593338;6674.6996385162665;6725.663716814164;6593.175853018372;6597.208334999795;6610.2398224204235;6617.073609694647;6620.966895165529;3757.4176002719487;4941.77762000709;4947.752612369376;4947.876303092434;4947.9505204947845;4719.834805781781;4819.7590120494015;4930.876728081808;4949.579285760715;4965.453800081988;4767;4767.427908650967;4769.546893045155;4779.761011949406;4793.9280910786365;4510.271285872033;4842.830500932468;4871.12319782439;4889.48660390661;4904.901901961958;4198.727082739612;4201.117765269297;4234.788260586989;4238.639715624176;4250;5477.424870388591;6018.428249316308;6335.271443783931;6350.904736428957;6354.2692590352235;4684.531546845323;5544.500994910478;5627;5760;5792.131180322943;5790.913136302959;7005.054317667101;7005.719771209146;7012.368886800162;7016.964915175391;4689.085628302482;4689.859304220845;4698.741569213692;4707.576318131385;4713.198756211418;5932.317783454915;6060.36366181549;7484.4012479002095;7488.588127652977;7496.587687677175;3727.869524566627;4780.306855506002;4783.617310615143;4809.422869255712;4814.061258054646;4825.324454576362;4886.169351210303;4892.19278818998;4892.730899800474;4894.559489645949;5776.133579962955;5791.305043394736;5829.242198514166;5859.1797148399255;5867.677277749679;6924.723011079601;7122.821929451701;7148.249433809479;7148.606826624586;7152.070230869954;1390.57587435831;1703.8977661340111;1704.9573760655835;1707.5901783571853;1710.863130949521;1099.4173088263233;1108.972275693098;1119.3843386137592;1124.966251012471;1130.773845230957;6727.865442691119;6758.425533829582;6761.01965215041;6765.357291057342;6778.491613129035;7384.815379615553;7397.8150546236775;7401.888971665429;7409.666565004588;7417.666205020787;6199.535034872402;6745.8650826983185;6748.19021717397;6752.932470675329;6753.45972322213;3528.59421166564;3753.9624603753614;3911.5501717302873;3915.530136383595;3924.9215015699524;7639.968604238467;7699;7709.3447057000785;7716.6527506262355;7720.806979825549;7602.8099297518;7605.087389513294;7605.733799316998;7611.3530349919765;7623.9618801905635;6191.938080619227;7417.517861339104;7587.696492140252;7695.653695583712;7697.461177717506;7263.273672632906;7381.077365329334;7383.2985866342615;7386.2613738625705;7386.593737344498;5964.731587078505;6940.861182776215;7187.7843664690145;7238.27617238272;7321.5607063574225;6774.627395493098;7773.805654858674;7774.6890124394395;7784.221577842397;7805;4677.158111539956;4849.975750121368;4866.440359358578;4867.70793752376;4876.90246195067;7368.152662443673;7402.444816638881;7420;7420.777376678709;7424.777256682308;7146.892796607951;7157.212706602166;7158.856822863618;7161.319674630901;7171.677274522554;7092.964535177498;7105.680244388912;7109.537880037781;7113.82215444618;7123.786286411416;6731.966340168267;7002.579845209304;7008.299170082951;7030.648467576703;7034.964825175842;6498.805035848932;6503.317151699003;7159.355657990597;7172.713091476283;7173.390261827803;6995.510314277952;7002.404795592432;7002.614856182959;7005.089338386181;7008.299170082951 10:44:57 INFO - PROCESS | 1672 | |5;yui.html;649.2663290481757;674.4132604633968;697.2365260040254;730.349988510226;779.5751315533038;11928.940355298222;14621.634459138513;14851.628709282246;14875.404983800649;14886.255687215624;14967.625809354771;15373.231338433061;15378.23108844559;15385;15396.153211573359;696.8850139726965;705.8376573388124;841.0076110189989;869.695606537713;875.1423604867234;825.859603867344;859.3597769661579;871.4727589808169;872.2193636695154;874.2656168818191;831.301706566487;913.9771505712343;914.1041779056495;914.6935776514875;918.1507105927025;719.5466855880787;894.5571941888742;910.7176775199644;910.7358865928873;912.4297314178639;676.5839009009424;676.614329831996;677.7831094049906;678.7658257901065;678.9185297764251;13308.534201303004;13349.599512014654;13408.26254555999;13409.798853017213;13411;11560.306381617045;12127.811921952372;12162.087843411691;12307.56923507673;12493.500259989589;10047.698569042941;10104.848427273597;10105.545250463672;10264.230182736324;10810.72973175669;3428.434308339146;3461.3423449544507;3469.774464659789;3470.219200679827;3478.2000139967695;75131.62434187849;75865.6206718963;75936;75980.62009689971;76437.61781191114;9105.317101217435;9146.95426522863;9163.221126204347;9182.219511341476;9382.577783999737;20205.88867612266;20215.39353819388;20241.696374554394;20257.189712411633;20261.594768104555;7096.858062838714;7134.286571342928;7153.105861767279;7322.121345438582;7333.669984850694;3979.2041591681777;4046.716729828943;4054.108096218827;4066.573009833984;4077.2864748668862;3414.5219669246326;3451.516787649731;3463.705585025301;3466.116140384236;3467.994281658341;505.8280184737207;551.2613098448098;630.9716062777186;647.6049609738056;690.5683947532792;505.1210893046073;544.7875328621841;557.1586903775328;557.8326502049368;598.5690302981847;8233.423660343718;8249.711260105867;8392.20274073962;8396.496210227406;8482.745517634481;505.27493047476986;556.7466802604805;576.9240366716128;599.9100134979788;629.8929182039064;3791;3925.371940489565;3966.484357033567;4002.239574480839;4070.470838790938;75245;87587;92323;92560;92701.53649231845;74054.62972685102;74158.62920685361;74847.62576187192;75052.62473687597;75212.62393687997;67148.6642566784;67600;67744.32255677479;68634.65682671555;70067.2993270071;7827.982362292865;8243.266724587316;8632.78418039554;8639.265662418766;8835.514046727492;52091.73954130205;52315.73842130765;52789.999999998465;53678.19482707684;54373.912521750135;71754.28245717476;73595.89606155804;73770.63114684392;74296.62851685708;75173.62413187898;10766.730831728955;10771.89228107709;10984.945075274572;11068.059214966817;11456.803841422041;9819.803603928025;11879.109066820196;12031.518739250332;12067;12182.573609923611;11325.603603873826;11384.918432748877;11413.258138220988;11413.771724565628;11442.771144577227;11528.711782205512;11564.653060408202;11572.132090093108;11578;11580.305181689126;11260.436978150896;11274.379909105079;11275.830862537232;11280;11290.717732056764;9544.809103817746;9952.452615106238;10070.345427547187;10105.747356316151;10141.594336226468;7930.680128902254;9383.859242111237;9740.269479789185;9877.357971731815;9898.703038908845 10:44:57 INFO - PROCESS | 1672 | __end_tp_report 10:44:57 INFO - PROCESS | 1672 | __start_cc_report 10:44:57 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1511 10:44:57 INFO - PROCESS | 1672 | __end_cc_report 10:44:57 INFO - PROCESS | 1672 | __startTimestamp1456339497624__endTimestamp 10:44:57 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | ------- Summary: start ------- 10:44:57 INFO - PROCESS | 1672 | Number of tests: 6 10:44:57 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5661.30 Median:5839.47 stddev:635.96 (10.9%) stddev-sans-first:608.06 10:44:57 INFO - PROCESS | 1672 | Values: 3206.8 3483.5 3501.8 3508.1 3561.2 5518.1 5574.6 5618.9 5621.9 5637.4 5596.4 5620.9 5670.0 5774.7 5839.5 5042.9 5064.4 5066.0 5077.7 5235.5 5219.2 5219.7 5235.2 5288.9 5294.4 5059.4 5098.0 5153.0 5181.8 5217.3 5129.0 5136.0 5153.9 5159.7 5173.0 5105.4 5125.8 5143.5 5174.1 5185.0 5477.2 5544.1 5605.6 5634.4 5665.9 6163.3 6168.6 6172.6 6182.8 6191.8 6210.6 6242.6 6250.7 6258.9 6276.4 5603.8 5678.6 5707.9 5721.7 5777.0 6266.2 6280.2 6291.6 6295.5 6331.1 5863.4 6043.6 6048.5 6097.0 6115.7 6132.0 6138.9 6237.6 6237.7 6257.2 6131.8 6141.5 6163.9 6171.2 6186.5 6051.1 6136.5 6182.5 6186.9 6193.7 4843.9 4853.7 4873.8 4875.5 4910.4 4326.9 4338.1 4354.9 4359.3 4388.6 5563.1 5650.0 5678.2 5706.1 5711.9 5127.5 6193.0 6196.4 6198.5 6240.0 5678.1 5684.3 5686.3 5692.4 5696.7 5208.0 5213.9 5299.0 5310.9 5314.6 6285.0 6293.2 6307.4 6311.5 6337.2 6148.8 6171.8 6201.1 6267.2 6287.1 6215.9 6257.4 6272.2 6274.8 6284.0 5057.4 6043.5 6107.3 6126.6 6141.2 6125.2 6129.4 6236.5 6259.9 6268.1 4698.4 5025.6 5255.6 6032.9 6051.0 5845.1 5964.3 5974.7 5995.9 6001.2 5812.2 5838.7 5839.9 5844.7 5855.2 5960.8 5981.8 6019.2 6090.3 6095.2 5277.1 5882.6 5898.1 5942.8 5957.4 10:44:57 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:57924.10 Median:35816.99 stddev:118560.93 (331.0%) stddev-sans-first:118815.03 10:44:57 INFO - PROCESS | 1672 | Values: 461.5 543.6 557.4 586.8 591.5 36427.6 36624.0 36740.8 36743.4 36788.0 37539.4 38034.6 38042.0 38079.8 38102.2 9254.4 9475.5 9484.2 9491.6 9502.8 9365.7 9616.8 9618.7 9628.5 9648.6 9568.6 9646.2 9649.7 9651.3 9667.2 9558.0 9628.3 9638.7 9645.6 9668.8 9411.0 9544.9 9564.0 9572.0 9582.8 37064.3 37275.6 37387.3 37395.3 37455.8 2599.8 3033.4 3088.9 3128.4 3328.5 24008.8 27488.7 27722.6 28344.9 29087.4 2725.7 2770.9 2839.7 2852.5 2938.6 395997.0 470148.0 471324.0 471604.6 472092.0 52624.0 53656.7 59203.4 60101.4 60123.4 49776.3 50046.0 50165.5 62624.7 63645.7 15868.4 16096.3 16187.8 16259.2 16259.9 12423.1 12531.9 12537.9 12547.6 12578.2 16495.7 18403.1 18889.2 18901.4 19076.3 8126.9 8322.2 8352.8 8438.8 8464.4 959.4 977.0 985.0 1008.3 1018.1 28523.9 28647.9 28730.1 29141.0 29183.4 1077.0 1097.3 1114.5 1168.7 1205.2 12414.8 14348.7 14596.9 14678.9 14912.6 511405.0 524317.0 528277.0 529390.0 529567.0 56029.7 56097.9 56177.4 56188.3 56290.7 1402.2 1424.8 1442.6 1443.2 1443.3 27125.6 27928.7 28824.6 28842.9 29632.9 46001.5 49354.3 49945.3 51651.0 52571.4 329943.0 333371.7 336720.3 336725.0 336852.0 29951.3 30335.7 30371.1 30401.2 30403.2 34698.8 41683.6 42656.4 43113.1 43800.8 33117.8 33473.2 34101.8 34159.8 35634.0 29846.6 33054.8 33669.3 33680.5 33695.0 33666.0 35451.5 35775.5 35858.5 35877.1 28147.0 30267.8 30310.4 30394.5 30509.7 23498.5 23519.5 23818.0 23900.3 23943.0 10:44:57 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:29479.55 Median:24249.50 stddev:81258.11 (335.1%) stddev-sans-first:81456.53 10:44:57 INFO - PROCESS | 1672 | Values: 305.2 358.1 360.1 361.2 366.3 15681.6 16178.5 18967.9 19392.4 20509.3 15328.1 16258.6 19397.4 19435.2 19455.5 5601.2 5619.2 5821.7 5829.6 5845.5 3872.6 5665.6 5785.0 5800.1 5805.7 5652.7 5893.7 5907.5 5910.2 5914.0 5809.2 5870.0 5890.8 5902.5 6263.9 5601.4 5652.9 5655.3 5661.1 5670.1 12666.2 12861.5 19879.6 25083.1 25151.1 2105.9 2286.1 2344.3 2660.6 2745.9 9703.6 9719.5 10207.5 12873.9 13958.3 1680.9 1746.9 1764.1 1817.6 1841.6 77511.0 77561.0 89542.6 106649.5 114329.3 10292.0 11156.0 11223.4 11292.3 11332.4 13413.5 13477.4 13515.8 13549.7 13555.2 8515.8 8527.4 8529.4 8548.4 8621.6 8727.0 8733.3 8734.1 8753.6 8801.3 4393.7 4419.4 4419.5 4426.1 4454.4 1791.5 1859.5 1863.6 1865.7 1866.6 841.3 868.9 896.5 946.0 977.8 19527.5 19691.5 19998.8 20248.8 20276.9 792.5 897.9 926.7 954.6 971.1 6164.6 6209.5 6213.1 6235.1 10613.5 405880.0 409436.0 409549.0 520677.0 637766.0 93737.0 99125.0 120711.0 121446.4 125403.0 462.8 468.8 473.4 474.5 477.0 8930.5 9625.5 11333.5 11364.7 11593.4 39788.6 44105.3 49788.0 50804.5 52253.6 68319.7 70318.0 70761.6 71457.6 71567.0 7937.5 8021.2 8073.4 8141.5 8391.8 9512.4 13298.6 13434.6 13536.2 13679.3 11527.8 11753.4 11770.8 11790.6 11806.8 5589.8 10344.9 11084.6 11425.7 11674.3 11849.9 11899.6 11901.8 11954.2 11972.5 6270.6 7382.8 8207.1 8393.9 8395.8 10364.3 11876.3 12003.6 12035.5 12056.3 10:44:57 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5797.88 Median:5378.30 stddev:3037.63 (56.5%) stddev-sans-first:3026.70 10:44:57 INFO - PROCESS | 1672 | Values: 1224.7 1375.8 1517.7 1693.6 1949.3 7589.1 8171.3 8343.7 8366.1 8404.8 8061.1 8344.6 8362.0 8362.6 8369.0 2117.0 2178.4 2182.8 2386.6 2421.0 2383.1 2449.3 2449.6 2452.1 2454.4 2359.2 2398.7 2407.9 2411.6 2415.5 2372.2 2383.8 2386.2 2398.4 2412.3 2394.6 2396.9 2399.3 2399.5 2407.8 8421.3 8490.3 8497.7 8510.2 8512.7 5192.1 5371.1 5372.2 5376.9 5379.7 3535.5 3572.0 3620.9 3664.6 3667.9 1027.2 1046.1 1059.2 1061.1 1077.5 11044.5 11204.6 11236.5 11237.0 11252.3 4322.0 4398.4 4725.0 4781.0 4789.6 9626.7 9632.1 9657.0 9664.0 9671.0 5276.1 5306.8 5322.6 5336.5 5345.9 4294.6 4460.7 4678.4 4817.5 4858.6 3798.8 3817.7 3817.8 3856.4 3868.1 1264.5 1272.5 1275.7 1288.4 1289.5 1099.9 1114.0 1114.5 1255.8 1349.7 7788.9 7857.9 7891.4 7914.0 7918.3 502.3 514.5 518.2 518.3 521.5 6000.4 6058.0 6075.3 6077.3 6088.7 9841.5 10049.4 10097.2 10140.2 10191.5 8980.9 9942.9 10005.1 10047.1 10071.9 7452.8 7885.1 7899.2 7907.2 7983.2 7670.7 7674.0 7776.2 7776.7 7879.5 9056.6 9343.8 9347.5 9445.9 9464.5 7928.9 9557.5 9557.7 9569.7 9854.6 5900.2 6613.1 6795.3 7222.9 7364.3 7916.1 7922.2 7975.8 7984.1 8010.4 6960.5 7048.0 7082.6 7179.4 7183.5 6951.8 6977.4 7031.3 7054.8 7109.5 7336.6 7407.6 7507.1 7534.3 7569.1 6779.7 6789.7 6842.1 6858.0 6869.8 6911.8 6938.5 6942.2 6983.7 6989.2 10:44:57 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5793.26 Median:6613.66 stddev:1849.93 (28.0%) stddev-sans-first:1808.83 10:44:57 INFO - PROCESS | 1672 | Values: 313.7 321.2 324.8 329.1 332.0 6634.8 6645.9 6659.3 6674.7 6725.7 6593.2 6597.2 6610.2 6617.1 6621.0 3757.4 4941.8 4947.8 4947.9 4948.0 4719.8 4819.8 4930.9 4949.6 4965.5 4767.0 4767.4 4769.5 4779.8 4793.9 4510.3 4842.8 4871.1 4889.5 4904.9 4198.7 4201.1 4234.8 4238.6 4250.0 5477.4 6018.4 6335.3 6350.9 6354.3 4684.5 5544.5 5627.0 5760.0 5792.1 5790.9 7005.1 7005.7 7012.4 7017.0 4689.1 4689.9 4698.7 4707.6 4713.2 5932.3 6060.4 7484.4 7488.6 7496.6 3727.9 4780.3 4783.6 4809.4 4814.1 4825.3 4886.2 4892.2 4892.7 4894.6 5776.1 5791.3 5829.2 5859.2 5867.7 6924.7 7122.8 7148.2 7148.6 7152.1 1390.6 1703.9 1705.0 1707.6 1710.9 1099.4 1109.0 1119.4 1125.0 1130.8 6727.9 6758.4 6761.0 6765.4 6778.5 7384.8 7397.8 7401.9 7409.7 7417.7 6199.5 6745.9 6748.2 6752.9 6753.5 3528.6 3754.0 3911.6 3915.5 3924.9 7640.0 7699.0 7709.3 7716.7 7720.8 7602.8 7605.1 7605.7 7611.4 7624.0 6191.9 7417.5 7587.7 7695.7 7697.5 7263.3 7381.1 7383.3 7386.3 7386.6 5964.7 6940.9 7187.8 7238.3 7321.6 6774.6 7773.8 7774.7 7784.2 7805.0 4677.2 4850.0 4866.4 4867.7 4876.9 7368.2 7402.4 7420.0 7420.8 7424.8 7146.9 7157.2 7158.9 7161.3 7171.7 7093.0 7105.7 7109.5 7113.8 7123.8 6732.0 7002.6 7008.3 7030.6 7035.0 6498.8 6503.3 7159.4 7172.7 7173.4 6995.5 7002.4 7002.6 7005.1 7008.3 10:44:57 INFO - PROCESS | 1672 | 10:44:57 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:18055.12 Median:587.75 stddev:25214.39 (4290.0%) stddev-sans-first:25251.25 10:44:57 INFO - PROCESS | 1672 | Values: 649.3 674.4 697.2 730.3 779.6 11928.9 14621.6 14851.6 14875.4 14886.3 14967.6 15373.2 15378.2 15385.0 15396.2 696.9 705.8 841.0 869.7 875.1 825.9 859.4 871.5 872.2 874.3 831.3 914.0 914.1 914.7 918.2 719.5 894.6 910.7 910.7 912.4 676.6 676.6 677.8 678.8 678.9 13308.5 13349.6 13408.3 13409.8 13411.0 11560.3 12127.8 12162.1 12307.6 12493.5 10047.7 10104.8 10105.5 10264.2 10810.7 3428.4 3461.3 3469.8 3470.2 3478.2 75131.6 75865.6 75936.0 75980.6 76437.6 9105.3 9147.0 9163.2 9182.2 9382.6 20205.9 20215.4 20241.7 20257.2 20261.6 7096.9 7134.3 7153.1 7322.1 7333.7 3979.2 4046.7 4054.1 4066.6 4077.3 3414.5 3451.5 3463.7 3466.1 3468.0 505.8 551.3 631.0 647.6 690.6 505.1 544.8 557.2 557.8 598.6 8233.4 8249.7 8392.2 8396.5 8482.7 505.3 556.7 576.9 599.9 629.9 3791.0 3925.4 3966.5 4002.2 4070.5 75245.0 87587.0 92323.0 92560.0 92701.5 74054.6 74158.6 74847.6 75052.6 75212.6 67148.7 67600.0 67744.3 68634.7 70067.3 7828.0 8243.3 8632.8 8639.3 8835.5 52091.7 52315.7 52790.0 53678.2 54373.9 71754.3 73595.9 73770.6 74296.6 75173.6 10766.7 10771.9 10984.9 11068.1 11456.8 9819.8 11879.1 12031.5 12067.0 12182.6 11325.6 11384.9 11413.3 11413.8 11442.8 11528.7 11564.7 11572.1 11578.0 11580.3 11260.4 11274.4 11275.8 11280.0 11290.7 9544.8 9952.5 10070.3 10105.7 10141.6 7930.7 9383.9 9740.3 9877.4 9898.7 10:44:57 INFO - PROCESS | 1672 | -------- Summary: end -------- 10:44:57 INFO - PROCESS | 1672 | 10:44:58 INFO - TEST-INFO | 1672: exit 0 10:44:58 INFO - TEST-OK | dromaeo_css | took 1113591ms 10:44:58 INFO - TEST-START | kraken 10:44:58 INFO - operating with platform_type : mac_ 10:44:58 INFO - Initialising browser for kraken test... 10:44:58 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpTqulru/profile http://localhost:49283/getInfo.html) 10:45:00 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 10:45:00 INFO - PROCESS | 1682 | colorDepth:24 10:45:00 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 10:45:00 INFO - PROCESS | 1682 | __metrics 10:45:00 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:45:00 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:45:00 INFO - TEST-INFO | 1682: exit 0 10:45:00 INFO - Browser initialized. 10:45:00 INFO - Running cycle 1/1 for kraken test... 10:45:00 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpTqulru/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:12 INFO - PROCESS | 1684 | RSS: Main: 242995200 10:45:12 INFO - PROCESS | 1684 | 10:45:15 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 10:45:15 INFO - PROCESS | 1684 | RSS: Main: 288436224 10:45:15 INFO - PROCESS | 1684 | 10:45:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 10:45:19 INFO - PROCESS | 1684 | RSS: Main: 300318720 10:45:19 INFO - PROCESS | 1684 | 10:45:22 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 10:45:23 INFO - PROCESS | 1684 | RSS: Main: 285954048 10:45:23 INFO - PROCESS | 1684 | 10:45:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 10:45:25 INFO - PROCESS | 1684 | RSS: Main: 289644544 10:45:25 INFO - PROCESS | 1684 | 10:45:27 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:45:28 INFO - PROCESS | 1684 | RSS: Main: 290578432 10:45:28 INFO - PROCESS | 1684 | 10:45:31 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 10:45:31 INFO - PROCESS | 1684 | RSS: Main: 289611776 10:45:31 INFO - PROCESS | 1684 | 10:45:34 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 10:45:35 INFO - PROCESS | 1684 | RSS: Main: 289841152 10:45:35 INFO - PROCESS | 1684 | 10:45:38 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 10:45:38 INFO - PROCESS | 1684 | RSS: Main: 291463168 10:45:38 INFO - PROCESS | 1684 | 10:45:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:45:40 INFO - PROCESS | 1684 | RSS: Main: 325820416 10:45:40 INFO - PROCESS | 1684 | 10:45:42 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:45:43 INFO - PROCESS | 1684 | RSS: Main: 324292608 10:45:43 INFO - PROCESS | 1684 | 10:45:45 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:45:45 INFO - PROCESS | 1684 | RSS: Main: 330784768 10:45:45 INFO - PROCESS | 1684 | 10:45:48 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:45:49 INFO - PROCESS | 1684 | RSS: Main: 333570048 10:45:49 INFO - PROCESS | 1684 | 10:45:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:45:52 INFO - PROCESS | 1684 | RSS: Main: 333463552 10:45:52 INFO - PROCESS | 1684 | 10:45:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 10:45:54 INFO - PROCESS | 1684 | RSS: Main: 393588736 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | __start_tp_report 10:45:54 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 10:45:54 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 10:45:54 INFO - PROCESS | 1684 | |i|pagename|runs| 10:45:54 INFO - PROCESS | 1684 | |0;ai-astar;110;109;112;112;110;111;115;111;112;112 10:45:54 INFO - PROCESS | 1684 | |1;audio-beat-detection;161;122;145;157;122;142;143;119;159;119 10:45:54 INFO - PROCESS | 1684 | |2;audio-dft;186;185;186;184;188;181;184;187;181;183 10:45:54 INFO - PROCESS | 1684 | |3;audio-fft;74;76;85;76;56;57;60;83;124;84 10:45:54 INFO - PROCESS | 1684 | |4;audio-oscillator;94;90;123;79;103;121;146;78;77;109 10:45:54 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;87;93;87;93;87;92;86;94;87;94 10:45:54 INFO - PROCESS | 1684 | |6;imaging-darkroom;95;95;96;96;96;97;95;96;96;96 10:45:54 INFO - PROCESS | 1684 | |7;imaging-desaturate;123;132;94;86;85;87;86;85;103;141 10:45:54 INFO - PROCESS | 1684 | |8;json-parse-financial;55;52;54;53;53;53;53;64;52;52 10:45:54 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;63;65;67;75;70;67;65;66;67;68 10:45:54 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;95;107;107;82;84;81;82;82;84;84 10:45:54 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;122;125;113;131;136;126;126;104;129;125 10:45:54 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;136;125;145;138;137;127;138;136;137;136 10:45:54 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;67;89;93;93;66;67;66;67;76;96 10:45:54 INFO - PROCESS | 1684 | __end_tp_report 10:45:54 INFO - PROCESS | 1684 | __start_cc_report 10:45:54 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1153 10:45:54 INFO - PROCESS | 1684 | __end_cc_report 10:45:54 INFO - PROCESS | 1684 | __startTimestamp1456339554184__endTimestamp 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | ------- Summary: start ------- 10:45:54 INFO - PROCESS | 1684 | Number of tests: 14 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:1.65 (1.5%) stddev-sans-first:1.67 10:45:54 INFO - PROCESS | 1684 | Values: 110.0 109.0 112.0 112.0 110.0 111.0 115.0 111.0 112.0 112.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:144.00 stddev:17.15 (11.9%) stddev-sans-first:16.22 10:45:54 INFO - PROCESS | 1684 | Values: 161.0 122.0 145.0 157.0 122.0 142.0 143.0 119.0 159.0 119.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.50 stddev:2.37 (1.3%) stddev-sans-first:2.45 10:45:54 INFO - PROCESS | 1684 | Values: 186.0 185.0 186.0 184.0 188.0 181.0 184.0 187.0 181.0 183.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:77.50 Median:76.00 stddev:19.71 (25.9%) stddev-sans-first:20.87 10:45:54 INFO - PROCESS | 1684 | Values: 74.0 76.0 85.0 76.0 56.0 57.0 60.0 83.0 124.0 84.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:77.50 stddev:22.92 (29.6%) stddev-sans-first:24.12 10:45:54 INFO - PROCESS | 1684 | Values: 94.0 90.0 123.0 79.0 103.0 121.0 146.0 78.0 77.0 109.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:92.50 stddev:3.43 (3.7%) stddev-sans-first:3.46 10:45:54 INFO - PROCESS | 1684 | Values: 87.0 93.0 87.0 93.0 87.0 92.0 86.0 94.0 87.0 94.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 10:45:54 INFO - PROCESS | 1684 | Values: 95.0 95.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:85.50 stddev:21.71 (25.4%) stddev-sans-first:21.68 10:45:54 INFO - PROCESS | 1684 | Values: 123.0 132.0 94.0 86.0 85.0 87.0 86.0 85.0 103.0 141.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.00 stddev:3.60 (6.8%) stddev-sans-first:3.81 10:45:54 INFO - PROCESS | 1684 | Values: 55.0 52.0 54.0 53.0 53.0 53.0 53.0 64.0 52.0 52.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:3.30 (4.9%) stddev-sans-first:3.11 10:45:54 INFO - PROCESS | 1684 | Values: 63.0 65.0 67.0 75.0 70.0 67.0 65.0 66.0 67.0 68.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:83.00 stddev:10.38 (12.5%) stddev-sans-first:10.76 10:45:54 INFO - PROCESS | 1684 | Values: 95.0 107.0 107.0 82.0 84.0 81.0 82.0 82.0 84.0 84.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:126.00 stddev:9.14 (7.3%) stddev-sans-first:9.68 10:45:54 INFO - PROCESS | 1684 | Values: 122.0 125.0 113.0 131.0 136.0 126.0 126.0 104.0 129.0 125.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:137.00 stddev:5.68 (4.1%) stddev-sans-first:6.02 10:45:54 INFO - PROCESS | 1684 | Values: 136.0 125.0 145.0 138.0 137.0 127.0 138.0 136.0 137.0 136.0 10:45:54 INFO - PROCESS | 1684 | 10:45:54 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:82.50 stddev:13.12 (15.9%) stddev-sans-first:13.30 10:45:54 INFO - PROCESS | 1684 | Values: 67.0 89.0 93.0 93.0 66.0 67.0 66.0 67.0 76.0 96.0 10:45:54 INFO - PROCESS | 1684 | -------- Summary: end -------- 10:45:54 INFO - PROCESS | 1684 | 10:45:55 INFO - TEST-INFO | 1684: exit 0 10:45:55 INFO - TEST-OK | kraken | took 56948ms 10:45:55 INFO - SUITE-END | took 1170s 10:45:55 INFO - Completed test suite (00:19:30) 10:45:55 INFO - Working with test: dromaeo_css 10:45:55 INFO - Generating results file: dromaeo_css 10:45:55 INFO - Working with test: kraken 10:45:55 INFO - Generating results file: kraken 10:45:55 INFO - javascript benchmark 10:45:55 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:45:55 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:45:55 INFO - process_Request line: dromaeo_css 7296.00 graph.html#tests=[[72,64,59]] 10:45:55 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:45:55 INFO - process_Request line: kraken 1449.70 graph.html#tests=[[232,64,59]] 10:45:55 INFO - RETURN: dromaeo_css: 7296.00 10:45:55 INFO - RETURN: kraken: 1449.70 10:45:55 INFO - javascript benchmark 10:45:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3206.807591544507, 3483.5471388719448, 3501.8249087545614, 3508.052825737051, 3561.216532362879, 5518.144687573433, 5574.554035677146, 5618.887622247553, 5621.943780562193, 5637.379888212298, 5596.4403559644015, 5620.859478513039, 5669.971650141754, 5774.6535207887455, 5839.474447299742, 5042.873928151789, 5064.417591976933, 5065.974670126644, 5077.720725360104, 5235.476452354753, 5219.217117432397, 5219.660722053073, 5235.240890070937, 5288.867778305554, 5294.364676238857, 5059.367579052619, 5098.031374038921, 5153.046686363016, 5181.81863634771, 5217.295665085203, 5128.974205158946, 5135.974320128375, 5153.922691159635, 5159.71621560814, 5173.0, 5105.361829771278, 5125.820596279113, 5143.537081662668, 5174.146265866128, 5185.0, 5477.1510415885605, 5544.140658197985, 5605.579581531401, 5634.4365563443735, 5665.943340566583, 6163.291221509539, 6168.629882207037, 6172.567920245585, 6182.783602573933, 6191.783287584958, 6210.627362358227, 6242.625442473466, 6250.6874656267455, 6258.9374106259265, 6276.435120839146, 5603.80386686464, 5678.574106942037, 5707.857303567444, 5721.713914304351, 5777.0467872801355, 6266.185395898504, 6280.214973128359, 6291.559590828598, 6295.527835412271, 6331.113644089831, 5863.442972917566, 6043.637381757108, 6048.485878700271, 6097.0, 6115.663638499836, 6132.04958718918, 6138.909559458743, 6237.563370564017, 6237.656928868865, 6257.186565746424, 6131.816045518642, 6141.539384546177, 6163.876722465526, 6171.228596425447, 6186.505079593621, 6051.122587224828, 6136.54971344134, 6182.536309776785, 6186.907196392058, 6193.6903154842075, 4843.878903027382, 4853.733044682576, 4873.805047798049, 4875.488073752205, 4910.435299940553, 4326.870193894189, 4338.132373525307, 4354.912901741947, 4359.280718681445, 4388.626966707801, 5563.082091454946, 5650.0, 5678.233438485834, 5706.087026075808, 5711.885762284731, 5127.4872512748425, 6193.040078787795, 6196.3803619638575, 6198.535109866778, 6240.00159974402, 5678.119891416837, 5684.289463817023, 5686.317641882918, 5692.430756924357, 5696.658200507983, 5208.0, 5213.895722085537, 5298.97350513245, 5310.92033619496, 5314.627976041717, 6284.968575157095, 6293.244810622755, 6307.400796924285, 6311.463525600376, 6337.239531256187, 6148.754049838135, 6171.814845554641, 6201.131841542278, 6267.1539342188225, 6287.119803227461, 6215.906761398673, 6257.405546473078, 6272.153259309935, 6274.780382686584, 6283.96858015707, 5057.443681194992, 6043.456088952015, 6107.328193898757, 6126.632402055891, 6141.232345956755, 6125.235451818428, 6129.358790882775, 6236.469900058546, 6259.874802504016, 6268.059791031382, 4698.436187657503, 5025.6482046256415, 5255.632105752714, 6032.939670603413, 6051.031834906394, 5845.064789633639, 5964.254468191476, 5974.731137098754, 5995.880082398415, 6001.159837622649, 5812.21535092774, 5838.708064596668, 5839.883202336015, 5844.707764611838, 5855.23881895368, 5960.802964548399, 5981.790637327673, 6019.157317975574, 6090.299615544269, 6095.238095238095, 5277.1292736698015, 5882.558808089325, 5898.144769008555, 5942.821715348547, 5957.374475680164], "unit": "score", "name": "dojo.html", "value": 5622.541900472158}, {"lowerIsBetter": false, "replicates": [461.4600916927193, 543.6411968101054, 557.4007941462926, 586.7799575159315, 591.4794980417232, 36427.63572364276, 36624.0, 36740.816295918485, 36743.4488482673, 36788.0, 37539.436908446325, 38034.61965380346, 38042.0489487763, 38079.80960095196, 38102.23795524088, 9254.44473331599, 9475.47884866332, 9484.241260699162, 9491.620335186584, 9502.80994380112, 9365.67220147295, 9616.759581010496, 9618.711438656817, 9628.47043412612, 9648.565814538362, 9568.617255309815, 9646.180074693659, 9649.662261820838, 9651.276154288422, 9667.178289845371, 9557.952210238938, 9628.3260171788, 9638.662646807397, 9645.565949532287, 9668.806623867553, 9410.952945235298, 9544.904550954541, 9563.952180239125, 9572.042795720441, 9582.808343833154, 37064.258714825824, 37275.62724372749, 37387.25225495502, 37395.25209495822, 37455.81272093649, 2599.805014623892, 3033.423649506609, 3088.9299241953117, 3128.436881361354, 3328.517364982088, 24008.759912400827, 27488.725112748816, 27722.5841612376, 28344.858275708695, 29087.41825163506, 2725.68654604721, 2770.9307267318277, 2839.7302256285825, 2852.472292625871, 2938.6326709161353, 395997.0, 470148.0, 471324.0, 471604.6419767914, 472091.9535632507, 52624.0, 53656.73171634117, 59203.407965920655, 60101.39898600958, 60123.39876601178, 49776.25335619968, 50045.9990800182, 50165.49834501608, 62624.68687656624, 63645.68177159177, 15868.44460443879, 16096.275667594986, 16187.838121618634, 16259.187040647921, 16259.918700406422, 12423.068269879795, 12531.937340313423, 12537.937310313573, 12547.560835370901, 12578.182418142791, 16495.670086598202, 18403.079846007648, 18889.244430222636, 18901.43295701131, 19076.33232836844, 8126.878096828552, 8322.20939010793, 8352.791180220422, 8438.789030274169, 8464.407491475538, 959.4195511715312, 976.9755756106155, 984.9753756156153, 1008.3143462445461, 1018.1193267823279, 28523.857380712965, 28647.856760716062, 28730.138095857157, 29140.9800656976, 29183.41633167325, 1076.9623063192907, 1097.2757979733337, 1114.5430373546808, 1168.655246702225, 1205.1925210109248, 12414.81377779334, 14348.70861622459, 14596.861674739981, 14678.89908256885, 14912.552623421314, 511405.0, 524317.0, 528277.0, 529390.0, 529567.0, 56029.719851400485, 56097.878042438926, 56177.43822561722, 56188.34775739564, 56290.718546407006, 1402.2287741742205, 1424.77203647418, 1442.6032840968608, 1443.2422977936667, 1443.2999995002415, 27125.59311610288, 27928.720712793423, 28824.567631485963, 28842.855785720938, 29632.851835740683, 46001.53998460106, 49354.259686105455, 49945.25082123699, 51651.0, 52571.42285731434, 329943.0, 333371.6662833341, 336720.31639842625, 336725.0, 336852.0, 29951.251218719706, 30335.696643033287, 30371.088867334016, 30401.239969000068, 30403.2399190022, 34698.826505867306, 41683.58316416797, 42656.36015459709, 43113.13773724571, 43800.780996094814, 33117.83441082779, 33473.15897625654, 34101.82949085239, 34159.829200853834, 35634.0, 29846.55230171506, 33054.843080492064, 33669.32661346808, 33680.49479257862, 33695.0, 33666.0, 35451.46822797608, 35775.46336804898, 35858.51768528934, 35877.1030724234, 28147.014854479996, 30267.848660756554, 30310.427116357045, 30394.544081838347, 30509.71177161766, 23498.530029398975, 23519.52960940806, 23818.0, 23900.28299151028, 23943.0], "unit": "score", "name": "ext.html", "value": 18819.75957548531}, {"lowerIsBetter": false, "replicates": [305.2247291878628, 358.1368900948713, 360.0656296909519, 361.1548975397569, 366.27112047026424, 15681.607959800982, 16178.514644560653, 18967.905160474194, 19392.41822745318, 20509.282175123873, 15328.080315181069, 16258.593535161626, 19397.4180774577, 19435.222591096375, 19455.513612159702, 5601.187827764982, 5619.185218143367, 5821.67980761058, 5829.5919285650025, 5845.503132233765, 3872.554656214529, 5665.603407761459, 5785.0, 5800.100984347433, 5805.73874175661, 5652.689102099383, 5893.675847828367, 5907.468327850493, 5910.172575839386, 5914.0, 5809.244798176232, 5870.0, 5890.793822216223, 5902.527797776168, 6263.874722505524, 5601.411851755588, 5652.9152062719095, 5655.293088363955, 5661.065924122515, 5670.092785154356, 12666.176698514659, 12861.485540578366, 19879.60240795176, 25083.12209072692, 25151.119710810217, 2105.947351316214, 2286.142696488817, 2344.2732752846673, 2660.5743081107125, 2745.917622471329, 9703.563339649732, 9719.514024298756, 10207.489625518769, 12873.87126128736, 13958.255218097738, 1680.8991460512286, 1746.8777185597014, 1764.1091248919213, 1817.6092140189924, 1841.6040551281405, 77511.0, 77561.0, 89542.5522872388, 106649.46675266574, 114329.28506072416, 10292.0, 11156.0, 11223.438828058564, 11292.322460652387, 11332.3935494835, 13413.463461461432, 13477.393517291745, 13515.797263041062, 13549.661258468617, 13555.186688798703, 8515.787105322293, 8527.360447966303, 8529.402941794138, 8548.444351117158, 8621.62054071358, 8727.0, 8733.301335893113, 8734.126587341216, 8753.64985400577, 8801.25189358899, 4393.670474714345, 4419.40338054365, 4419.513853476115, 4426.0926510066, 4454.443194600675, 1791.4625612316513, 1859.4700510354485, 1863.5993261448582, 1865.703336181368, 1866.57068874157, 841.2765022081005, 868.934829887761, 896.5338024227365, 945.9574319155516, 977.8337682593976, 19527.511812204808, 19691.50771230702, 19998.800011999694, 20248.797512024987, 20276.89861550712, 792.5482474989316, 897.9449147251953, 926.6571368593663, 954.6491714224434, 971.1308379000754, 6164.568480206342, 6209.472194863487, 6213.099100630474, 6235.095911092957, 10613.5223914924, 405880.0, 409436.0, 409549.0, 520677.0, 637766.0, 93737.0, 99125.0, 120711.0, 121446.3927680356, 125403.0, 462.82875336125846, 468.7726452670452, 473.3822361817792, 474.4567470246548, 477.01020382706025, 8930.508822014852, 9625.51872406363, 11333.489992950172, 11364.659060228207, 11593.420328983686, 39788.6073987409, 44105.338419923086, 49788.0, 50804.49195508145, 52253.59435301682, 68319.65840170767, 70318.0, 70761.64619177076, 71457.64271178818, 71567.0, 7937.484063535851, 8021.2379823916635, 8073.3541316693345, 8141.51150930946, 8391.790205244673, 9512.38169518979, 13298.601041968757, 13434.596962091153, 13536.187828730308, 13679.31603419845, 11527.8270825936, 11753.412329383325, 11770.823437648613, 11790.587329443428, 11806.763864722829, 5589.80435684749, 10344.948275258877, 11084.61203857861, 11425.657230283105, 11674.299542027506, 11849.881501184878, 11899.583514576949, 11901.766668489827, 11954.163208575315, 11972.461239244081, 6270.561060725706, 7382.778516644509, 8207.138250483853, 8393.916060839314, 8395.832083358177, 10364.326318789555, 11876.346800926032, 12003.579874704343, 12035.518579256732, 12056.336901470153], "unit": "score", "name": "jquery.html", "value": 8727.195877716615}, {"lowerIsBetter": false, "replicates": [1224.6999485126144, 1375.77299745542, 1517.6812869297446, 1693.6358682883185, 1949.2885096939622, 7589.051368578927, 8171.284030353626, 8343.707970221043, 8366.121557236478, 8404.789880252989, 8061.113277539481, 8344.582770861463, 8362.03836558796, 8362.581870906446, 8368.958155209231, 2116.9788302117013, 2178.4336072621154, 2182.8144607708364, 2386.630072338786, 2420.987895060522, 2383.1420688552107, 2449.3141920262356, 2449.632555116729, 2452.141750387359, 2454.361865914857, 2359.2096647623066, 2398.70016247969, 2407.8675672837985, 2411.553862535428, 2415.516896620683, 2372.240882917467, 2383.761623837611, 2386.164842305188, 2398.3764221302413, 2412.3486658602255, 2394.592919203722, 2396.8801559921935, 2399.2682231919257, 2399.472116134448, 2407.8201681176274, 8421.326293896534, 8490.320774338039, 8497.745067647918, 8510.191531804468, 8512.659493620247, 5192.1173400522, 5371.113766228567, 5372.247885296062, 5376.946230537723, 5379.65032272905, 3535.4520049392386, 3571.964280357189, 3620.8551657933913, 3664.5785734640326, 3667.8716244931566, 1027.1525991057333, 1046.1055797293282, 1059.2276547511824, 1061.0927656853435, 1077.520503375998, 11044.502997365138, 11204.607838725688, 11236.49435775384, 11236.988671019566, 11252.26860254081, 4321.962728945031, 4398.428204333481, 4724.95275047252, 4780.976095119502, 4789.640776941744, 9626.711198664052, 9632.121736261362, 9657.0, 9664.0, 9671.0, 5276.050310943991, 5306.7611957462, 5322.574194064543, 5336.519713225751, 5345.866353341197, 4294.634956028773, 4460.710053846489, 4678.391809064799, 4817.494163112823, 4858.6356023298395, 3798.8290526926353, 3817.6564109230303, 3817.828197731109, 3856.382978723391, 3868.052327179859, 1264.5384434681275, 1272.516443751387, 1275.6683262351855, 1288.4395288049727, 1289.4519829072606, 1099.8900109989097, 1113.9665810025713, 1114.5207560748956, 1255.8116282557507, 1349.6558377613646, 7788.883166752503, 7857.882131768028, 7891.368690504746, 7914.0, 7918.287354138155, 502.2992924869859, 514.5343464164937, 518.1528201390678, 518.2795913679988, 521.5097808060411, 6000.429959153874, 6058.000429929012, 6075.301340345828, 6077.3314935357075, 6088.695565221721, 9841.50792460374, 10049.447280399501, 10097.24270679702, 10140.239482038876, 10191.490425478696, 8980.8652870207, 9942.900570994341, 10005.149562287286, 10047.145992590566, 10071.942446043207, 7452.813679657944, 7885.093214280431, 7899.170587088273, 7907.209279072047, 7983.161768014391, 7670.7315243966195, 7674.0, 7776.222377762178, 7776.727814526691, 7879.487833290817, 9056.592453339746, 9343.813123737624, 9347.532623368668, 9445.913719922297, 9464.479453630116, 7928.920710792819, 9557.522123893916, 9557.665481708107, 9569.712908612753, 9854.605815767576, 5900.203472531153, 6613.074169616161, 6795.25252222265, 7222.855542889218, 7364.263573642593, 7916.050073991158, 7922.247386498273, 7975.840483190188, 7984.121746607984, 8010.439269251096, 6960.4779641526075, 7048.0, 7082.645867706491, 7179.353858152583, 7183.5330703504105, 6951.826204344729, 6977.406920411822, 7031.332023457763, 7054.788356349318, 7109.502334836719, 7336.559806411419, 7407.555546667218, 7507.136679281734, 7534.284242996907, 7569.091708994735, 6779.661016949034, 6789.694463749044, 6842.144731908512, 6857.965710171417, 6869.828254293682, 6911.7926462206215, 6938.469983532032, 6942.166939967236, 6983.720651173896, 6989.161300643956], "unit": "score", "name": "mootools.html", "value": 4664.485109534506}, {"lowerIsBetter": false, "replicates": [313.7129526483268, 321.1761830903732, 324.84569829331065, 329.1097581043278, 331.9834008299587, 6634.767783127591, 6645.86708265835, 6659.334066593338, 6674.6996385162665, 6725.663716814164, 6593.175853018372, 6597.208334999795, 6610.2398224204235, 6617.073609694647, 6620.966895165529, 3757.4176002719487, 4941.77762000709, 4947.752612369376, 4947.876303092434, 4947.9505204947845, 4719.834805781781, 4819.7590120494015, 4930.876728081808, 4949.579285760715, 4965.453800081988, 4767.0, 4767.427908650967, 4769.546893045155, 4779.761011949406, 4793.9280910786365, 4510.271285872033, 4842.830500932468, 4871.12319782439, 4889.48660390661, 4904.901901961958, 4198.727082739612, 4201.117765269297, 4234.788260586989, 4238.639715624176, 4250.0, 5477.424870388591, 6018.428249316308, 6335.271443783931, 6350.904736428957, 6354.2692590352235, 4684.531546845323, 5544.500994910478, 5627.0, 5760.0, 5792.131180322943, 5790.913136302959, 7005.054317667101, 7005.719771209146, 7012.368886800162, 7016.964915175391, 4689.085628302482, 4689.859304220845, 4698.741569213692, 4707.576318131385, 4713.198756211418, 5932.317783454915, 6060.36366181549, 7484.4012479002095, 7488.588127652977, 7496.587687677175, 3727.869524566627, 4780.306855506002, 4783.617310615143, 4809.422869255712, 4814.061258054646, 4825.324454576362, 4886.169351210303, 4892.19278818998, 4892.730899800474, 4894.559489645949, 5776.133579962955, 5791.305043394736, 5829.242198514166, 5859.1797148399255, 5867.677277749679, 6924.723011079601, 7122.821929451701, 7148.249433809479, 7148.606826624586, 7152.070230869954, 1390.57587435831, 1703.8977661340111, 1704.9573760655835, 1707.5901783571853, 1710.863130949521, 1099.4173088263233, 1108.972275693098, 1119.3843386137592, 1124.966251012471, 1130.773845230957, 6727.865442691119, 6758.425533829582, 6761.01965215041, 6765.357291057342, 6778.491613129035, 7384.815379615553, 7397.8150546236775, 7401.888971665429, 7409.666565004588, 7417.666205020787, 6199.535034872402, 6745.8650826983185, 6748.19021717397, 6752.932470675329, 6753.45972322213, 3528.59421166564, 3753.9624603753614, 3911.5501717302873, 3915.530136383595, 3924.9215015699524, 7639.968604238467, 7699.0, 7709.3447057000785, 7716.6527506262355, 7720.806979825549, 7602.8099297518, 7605.087389513294, 7605.733799316998, 7611.3530349919765, 7623.9618801905635, 6191.938080619227, 7417.517861339104, 7587.696492140252, 7695.653695583712, 7697.461177717506, 7263.273672632906, 7381.077365329334, 7383.2985866342615, 7386.2613738625705, 7386.593737344498, 5964.731587078505, 6940.861182776215, 7187.7843664690145, 7238.27617238272, 7321.5607063574225, 6774.627395493098, 7773.805654858674, 7774.6890124394395, 7784.221577842397, 7805.0, 4677.158111539956, 4849.975750121368, 4866.440359358578, 4867.70793752376, 4876.90246195067, 7368.152662443673, 7402.444816638881, 7420.0, 7420.777376678709, 7424.777256682308, 7146.892796607951, 7157.212706602166, 7158.856822863618, 7161.319674630901, 7171.677274522554, 7092.964535177498, 7105.680244388912, 7109.537880037781, 7113.82215444618, 7123.786286411416, 6731.966340168267, 7002.579845209304, 7008.299170082951, 7030.648467576703, 7034.964825175842, 6498.805035848932, 6503.317151699003, 7159.355657990597, 7172.713091476283, 7173.390261827803, 6995.510314277952, 7002.404795592432, 7002.614856182959, 7005.089338386181, 7008.299170082951], "unit": "score", "name": "prototype.html", "value": 5177.166703152161}, {"lowerIsBetter": false, "replicates": [649.2663290481757, 674.4132604633968, 697.2365260040254, 730.349988510226, 779.5751315533038, 11928.940355298222, 14621.634459138513, 14851.628709282246, 14875.404983800649, 14886.255687215624, 14967.625809354771, 15373.231338433061, 15378.23108844559, 15385.0, 15396.153211573359, 696.8850139726965, 705.8376573388124, 841.0076110189989, 869.695606537713, 875.1423604867234, 825.859603867344, 859.3597769661579, 871.4727589808169, 872.2193636695154, 874.2656168818191, 831.301706566487, 913.9771505712343, 914.1041779056495, 914.6935776514875, 918.1507105927025, 719.5466855880787, 894.5571941888742, 910.7176775199644, 910.7358865928873, 912.4297314178639, 676.5839009009424, 676.614329831996, 677.7831094049906, 678.7658257901065, 678.9185297764251, 13308.534201303004, 13349.599512014654, 13408.26254555999, 13409.798853017213, 13411.0, 11560.306381617045, 12127.811921952372, 12162.087843411691, 12307.56923507673, 12493.500259989589, 10047.698569042941, 10104.848427273597, 10105.545250463672, 10264.230182736324, 10810.72973175669, 3428.434308339146, 3461.3423449544507, 3469.774464659789, 3470.219200679827, 3478.2000139967695, 75131.62434187849, 75865.6206718963, 75936.0, 75980.62009689971, 76437.61781191114, 9105.317101217435, 9146.95426522863, 9163.221126204347, 9182.219511341476, 9382.577783999737, 20205.88867612266, 20215.39353819388, 20241.696374554394, 20257.189712411633, 20261.594768104555, 7096.858062838714, 7134.286571342928, 7153.105861767279, 7322.121345438582, 7333.669984850694, 3979.2041591681777, 4046.716729828943, 4054.108096218827, 4066.573009833984, 4077.2864748668862, 3414.5219669246326, 3451.516787649731, 3463.705585025301, 3466.116140384236, 3467.994281658341, 505.8280184737207, 551.2613098448098, 630.9716062777186, 647.6049609738056, 690.5683947532792, 505.1210893046073, 544.7875328621841, 557.1586903775328, 557.8326502049368, 598.5690302981847, 8233.423660343718, 8249.711260105867, 8392.20274073962, 8396.496210227406, 8482.745517634481, 505.27493047476986, 556.7466802604805, 576.9240366716128, 599.9100134979788, 629.8929182039064, 3791.0, 3925.371940489565, 3966.484357033567, 4002.239574480839, 4070.470838790938, 75245.0, 87587.0, 92323.0, 92560.0, 92701.53649231845, 74054.62972685102, 74158.62920685361, 74847.62576187192, 75052.62473687597, 75212.62393687997, 67148.6642566784, 67600.0, 67744.32255677479, 68634.65682671555, 70067.2993270071, 7827.982362292865, 8243.266724587316, 8632.78418039554, 8639.265662418766, 8835.514046727492, 52091.73954130205, 52315.73842130765, 52789.999999998465, 53678.19482707684, 54373.912521750135, 71754.28245717476, 73595.89606155804, 73770.63114684392, 74296.62851685708, 75173.62413187898, 10766.730831728955, 10771.89228107709, 10984.945075274572, 11068.059214966817, 11456.803841422041, 9819.803603928025, 11879.109066820196, 12031.518739250332, 12067.0, 12182.573609923611, 11325.603603873826, 11384.918432748877, 11413.258138220988, 11413.771724565628, 11442.771144577227, 11528.711782205512, 11564.653060408202, 11572.132090093108, 11578.0, 11580.305181689126, 11260.436978150896, 11274.379909105079, 11275.830862537232, 11280.0, 11290.717732056764, 9544.809103817746, 9952.452615106238, 10070.345427547187, 10105.747356316151, 10141.594336226468, 7930.680128902254, 9383.859242111237, 9740.269479789185, 9877.357971731815, 9898.703038908845], "unit": "score", "name": "yui.html", "value": 6763.247233340624}], "name": "dromaeo_css", "value": 7295.993830745667}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 112.0, 112.0, 110.0, 111.0, 115.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [161.0, 122.0, 145.0, 157.0, 122.0, 142.0, 143.0, 119.0, 159.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.9}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 186.0, 184.0, 188.0, 181.0, 184.0, 187.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.5}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 85.0, 76.0, 56.0, 57.0, 60.0, 83.0, 124.0, 84.0], "unit": "score", "name": "audio-fft", "value": 77.5}, {"lowerIsBetter": true, "replicates": [94.0, 90.0, 123.0, 79.0, 103.0, 121.0, 146.0, 78.0, 77.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 102.0}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 87.0, 93.0, 87.0, 92.0, 86.0, 94.0, 87.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 95.8}, {"lowerIsBetter": true, "replicates": [123.0, 132.0, 94.0, 86.0, 85.0, 87.0, 86.0, 85.0, 103.0, 141.0], "unit": "score", "name": "imaging-desaturate", "value": 102.2}, {"lowerIsBetter": true, "replicates": [55.0, 52.0, 54.0, 53.0, 53.0, 53.0, 53.0, 64.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.1}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 67.0, 75.0, 70.0, 67.0, 65.0, 66.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [95.0, 107.0, 107.0, 82.0, 84.0, 81.0, 82.0, 82.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.8}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 113.0, 131.0, 136.0, 126.0, 126.0, 104.0, 129.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [136.0, 125.0, 145.0, 138.0, 137.0, 127.0, 138.0, 136.0, 137.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [67.0, 89.0, 93.0, 93.0, 66.0, 67.0, 66.0, 67.0, 76.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.0}], "name": "kraken", "value": 1449.7}]} 10:45:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1449.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7296.00"}}} 10:45:55 INFO - Return code: 0 10:45:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:45:55 INFO - # TBPL SUCCESS # 10:45:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:45:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:45:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:45:55 INFO - 2016-02-24 10:45:55.987 screenresolution[1688:9696] starting screenresolution argv=screenresolution get 10:45:55 INFO - 2016-02-24 10:45:55.989 screenresolution[1688:9696] Display 0: 1600x1200x32@60 10:45:55 INFO - 2016-02-24 10:45:55.994 screenresolution[1689:9699] starting screenresolution argv=screenresolution list 10:45:55 INFO - Available Modes on Display 0 10:45:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:45:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:45:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:45:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:45:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:45:56 INFO - Intel Iris: 10:45:56 INFO - Chipset Model: Intel Iris 10:45:56 INFO - Type: GPU 10:45:56 INFO - Bus: Built-In 10:45:56 INFO - VRAM (Dynamic, Max): 1536 MB 10:45:56 INFO - Vendor: Intel (0x8086) 10:45:56 INFO - Device ID: 0x0a2e 10:45:56 INFO - Revision ID: 0x0009 10:45:56 INFO - Displays: 10:45:56 INFO - Display: 10:45:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:45:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:45:56 INFO - Display Serial Number: 1600x1200 60 10:45:56 INFO - Main Display: Yes 10:45:56 INFO - Mirror: Off 10:45:56 INFO - Online: Yes 10:45:56 INFO - Rotation: Supported 10:45:56 INFO - Return code: 0 10:45:56 INFO - Running post-action listener: _resource_record_post_action 10:45:56 INFO - Running post-run listener: _resource_record_post_run 10:45:57 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39458304; Write bytes: 708157440; Read time: 427; Write time: 2122 10:45:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 401734144; Write bytes: 396175360; Read time: 31507; Write time: 817 10:45:57 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37643776; Write bytes: 300423168; Read time: 406; Write time: 1251 10:45:57 INFO - Running post-run listener: _upload_blobber_files 10:45:57 INFO - Blob upload gear active. 10:45:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:45:57 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 10:45:57 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'] 10:45:57 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 10:45:57 INFO - (blobuploader) - INFO - Open directory for files ... 10:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:58 INFO - (blobuploader) - INFO - Done attempting. 10:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:59 INFO - (blobuploader) - INFO - Done attempting. 10:45:59 INFO - (blobuploader) - INFO - Iteration through files over. 10:45:59 INFO - Return code: 0 10:45:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:45:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:45:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/448e1bd8706e21efdf0eb5a24a90491959b7ba5a5eb8a7c55515918046070282f82390c1fa4de0136223e573b1d1d8b4c13622ea47861eb545f9d317b7f6d591", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9664a36f176cf296241de9aeb91eb2f7f2ea2e16a9d4144302e9eabcdef7ba1f90f3c16da098cd1d74870d9d2d840f5104eed6010ee42b94331c554f89ffe493"} 10:45:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:45:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:45:59 INFO - Contents: 10:45:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/448e1bd8706e21efdf0eb5a24a90491959b7ba5a5eb8a7c55515918046070282f82390c1fa4de0136223e573b1d1d8b4c13622ea47861eb545f9d317b7f6d591", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9664a36f176cf296241de9aeb91eb2f7f2ea2e16a9d4144302e9eabcdef7ba1f90f3c16da098cd1d74870d9d2d840f5104eed6010ee42b94331c554f89ffe493"} 10:45:59 INFO - Running post-run listener: copy_logs_to_upload_dir 10:45:59 INFO - Copying logs to upload dir... 10:45:59 INFO - mkdir: /builds/slave/test/build/upload/logs 10:45:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.541097 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-24 10:45:59.940797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 10:45:59.944177) ========= 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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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/448e1bd8706e21efdf0eb5a24a90491959b7ba5a5eb8a7c55515918046070282f82390c1fa4de0136223e573b1d1d8b4c13622ea47861eb545f9d317b7f6d591", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9664a36f176cf296241de9aeb91eb2f7f2ea2e16a9d4144302e9eabcdef7ba1f90f3c16da098cd1d74870d9d2d840f5104eed6010ee42b94331c554f89ffe493"} build_url:https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011001 build_url: 'https://queue.taskcluster.net/v1/task/SX5IZjB7RqmUPbUXj2bCyw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/448e1bd8706e21efdf0eb5a24a90491959b7ba5a5eb8a7c55515918046070282f82390c1fa4de0136223e573b1d1d8b4c13622ea47861eb545f9d317b7f6d591", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9664a36f176cf296241de9aeb91eb2f7f2ea2e16a9d4144302e9eabcdef7ba1f90f3c16da098cd1d74870d9d2d840f5104eed6010ee42b94331c554f89ffe493"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 10:45:59.970390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:45:59.970715) ========= 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.AtNA5gnmQQ/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.VkUs4yCIdU/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:46:00.019607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 10:46:00.019929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 10:46:00.020313) ========= ========= Total master_lag: 2.83 =========