builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0164 starttime: 1455542636.09 results: success (0) buildid: 20160215034121 builduid: 29a189c9a40c44c48697dbc12ac448f5 revision: fb1b8c571e954c651918fa22172ec69af05469fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.088368) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.088728) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.089000) ========= 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.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005632 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.122337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.122620) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.156356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.156689) ========= 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.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.004935 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.205214) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.205476) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.205799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.206063) ========= 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.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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-15 05:23:56-- 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% 65.0M=0s 2016-02-15 05:23:56 (65.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.476226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.697578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.697879) ========= 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.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.025628 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:56.751416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 05:23:56.751752) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fb1b8c571e954c651918fa22172ec69af05469fa --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 fb1b8c571e954c651918fa22172ec69af05469fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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-15 05:23:56,822 truncating revision to first 12 chars 2016-02-15 05:23:56,822 Setting DEBUG logging. 2016-02-15 05:23:56,823 attempt 1/10 2016-02-15 05:23:56,823 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fb1b8c571e95?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 05:23:57,769 unpacking tar archive at: fx-team-fb1b8c571e95/testing/mozharness/ program finished with exit code 0 elapsedTime=1.192139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 05:23:57.960014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:57.960359) ========= echo fb1b8c571e954c651918fa22172ec69af05469fa in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fb1b8c571e954c651918fa22172ec69af05469fa'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 fb1b8c571e954c651918fa22172ec69af05469fa program finished with exit code 0 elapsedTime=0.005944 script_repo_revision: 'fb1b8c571e954c651918fa22172ec69af05469fa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:58.013420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:58.013731) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 05:23:58.028248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-15 05:23:58.028591) ========= /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.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:23:58 INFO - MultiFileLogger online at 20160215 05:23:58 in /builds/slave/test 05:23:58 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 05:23:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:58 INFO - {'append_to_log': False, 05:23:58 INFO - 'base_work_dir': '/builds/slave/test', 05:23:58 INFO - 'blob_upload_branch': 'Fx-Team', 05:23:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:58 INFO - 'branch': 'Fx-Team', 05:23:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:58 INFO - 'config_files': ('talos/mac_config.py',), 05:23:58 INFO - 'default_actions': ('clobber', 05:23:58 INFO - 'read-buildbot-config', 05:23:58 INFO - 'download-and-extract', 05:23:58 INFO - 'populate-webroot', 05:23:58 INFO - 'create-virtualenv', 05:23:58 INFO - 'install', 05:23:58 INFO - 'run-tests'), 05:23:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:58 INFO - 'download_minidump_stackwalk': True, 05:23:58 INFO - 'download_symbols': 'ondemand', 05:23:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:58 INFO - 'installer_path': 'installer.exe', 05:23:58 INFO - 'log_level': 'info', 05:23:58 INFO - 'log_name': 'talos', 05:23:58 INFO - 'log_to_console': True, 05:23:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:23:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:23:58 INFO - 'opt_config_files': (), 05:23:58 INFO - 'pip_index': False, 05:23:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:58 INFO - 'cmd': ('bash', 05:23:58 INFO - '-c', 05:23:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:58 INFO - 'enabled': True, 05:23:58 INFO - 'halt_on_failure': False, 05:23:58 INFO - 'name': 'check_screen_resolution'},), 05:23:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:58 INFO - 'cmd': ('bash', 05:23:58 INFO - '-c', 05:23:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:58 INFO - 'enabled': True, 05:23:58 INFO - 'halt_on_failure': False, 05:23:58 INFO - 'name': 'check_screen_resolution'},), 05:23:58 INFO - 'run_cmd_checks_enabled': True, 05:23:58 INFO - 'sps_profile': False, 05:23:58 INFO - 'sps_profile_interval': 0, 05:23:58 INFO - 'suite': 'dromaeojs', 05:23:58 INFO - 'system_bits': '32', 05:23:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:58 INFO - 'title': 't-yosemite-r7-0164', 05:23:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:58 INFO - 'use_talos_json': True, 05:23:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:58 INFO - 'work_dir': 'build'} 05:23:58 INFO - ##### 05:23:58 INFO - ##### Running clobber step. 05:23:58 INFO - ##### 05:23:58 INFO - Running pre-action listener: _resource_record_pre_action 05:23:58 INFO - Running main action method: clobber 05:23:58 INFO - rmtree: /builds/slave/test/build 05:23:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:24:00 INFO - Running post-action listener: _resource_record_post_action 05:24:00 INFO - ##### 05:24:00 INFO - ##### Running read-buildbot-config step. 05:24:00 INFO - ##### 05:24:00 INFO - Running pre-action listener: _resource_record_pre_action 05:24:00 INFO - Running main action method: read_buildbot_config 05:24:00 INFO - Using buildbot properties: 05:24:00 INFO - { 05:24:00 INFO - "project": "", 05:24:00 INFO - "product": "firefox", 05:24:00 INFO - "script_repo_revision": "production", 05:24:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:24:00 INFO - "repository": "", 05:24:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:24:00 INFO - "buildid": "20160215034121", 05:24:00 INFO - "pgo_build": "False", 05:24:00 INFO - "basedir": "/builds/slave/test", 05:24:00 INFO - "buildnumber": 376, 05:24:00 INFO - "slavename": "t-yosemite-r7-0164", 05:24:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:24:00 INFO - "platform": "yosemite_r7", 05:24:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:24:00 INFO - "branch": "fx-team", 05:24:00 INFO - "repo_path": "integration/fx-team", 05:24:00 INFO - "revision": "fb1b8c571e954c651918fa22172ec69af05469fa", 05:24:00 INFO - "stage_platform": "macosx64", 05:24:00 INFO - "builduid": "29a189c9a40c44c48697dbc12ac448f5", 05:24:00 INFO - "slavebuilddir": "test" 05:24:00 INFO - } 05:24:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:24:00 INFO - Running post-action listener: _resource_record_post_action 05:24:00 INFO - ##### 05:24:00 INFO - ##### Running download-and-extract step. 05:24:00 INFO - ##### 05:24:00 INFO - Running pre-action listener: _resource_record_pre_action 05:24:00 INFO - Running main action method: download_and_extract 05:24:00 INFO - mkdir: /builds/slave/test/build/tests 05:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:00 INFO - https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:24:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/test_packages.json 05:24:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/test_packages.json 05:24:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:24:03 INFO - Downloaded 1277 bytes. 05:24:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:24:03 INFO - Using the following test package requirements: 05:24:03 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:24:03 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:24:03 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:24:03 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:24:03 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:24:03 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:24:03 INFO - u'jsshell-mac.zip'], 05:24:03 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:24:03 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:24:03 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:24:03 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:24:03 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:24:03 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:24:03 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:24:03 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:24:03 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:24:03 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:24:03 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:24:03 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:24:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:24: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')]} 05:24:03 INFO - https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:24:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:24:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:24:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/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 05:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/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 05:24:04 INFO - Downloaded 17758913 bytes. 05:24:04 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'] 05:24:04 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 05:24:07 INFO - Return code: 0 05:24:07 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 05:24:07 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')]} 05:24:07 INFO - https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/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 05:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/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 05:24:09 INFO - Downloaded 17758913 bytes. 05:24:09 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'] 05:24:09 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 05:24:12 INFO - Return code: 0 05:24:12 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')]} 05:24:12 INFO - https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:24:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:24:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:24:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/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 05:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/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 05:24:13 INFO - Downloaded 10707070 bytes. 05:24:13 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'] 05:24:13 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 05:24:14 INFO - Return code: 0 05:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:14 INFO - https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:24:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:24:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:24:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtJojU0cR2SUt5msVRBylg/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 05:24:21 INFO - Downloaded 111152255 bytes. 05:24:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:24:21 INFO - mkdir: /builds/slave/test/properties 05:24:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:21 INFO - Contents: 05:24:21 INFO - build_url:https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:24:22 INFO - Running post-action listener: _resource_record_post_action 05:24:22 INFO - Running post-action listener: set_extra_try_arguments 05:24:22 INFO - ##### 05:24:22 INFO - ##### Running populate-webroot step. 05:24:22 INFO - ##### 05:24:22 INFO - Running pre-action listener: _resource_record_pre_action 05:24:22 INFO - Running main action method: populate_webroot 05:24:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:22 INFO - '--tppagecycles', 05:24:22 INFO - '7'], 05:24:22 INFO - 'tests': ['tsvgm']}}, 05:24:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:24:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:24:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:24:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:24:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:22 INFO - 'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:22 INFO - 'tests': ['damp', 'tps']}, 05:24:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:22 INFO - 'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['damp', 'tps']}, 05:24:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:24:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:22 INFO - 'other': {'tests': ['a11yr', 05:24:22 INFO - 'ts_paint', 05:24:22 INFO - 'tpaint', 05:24:22 INFO - 'sessionrestore', 05:24:22 INFO - 'sessionrestore_no_auto_restore']}, 05:24:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['a11yr', 05:24:22 INFO - 'ts_paint', 05:24:22 INFO - 'tpaint', 05:24:22 INFO - 'sessionrestore', 05:24:22 INFO - 'sessionrestore_no_auto_restore']}, 05:24:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['a11yr', 05:24:22 INFO - 'ts_paint', 05:24:22 INFO - 'tpaint', 05:24:22 INFO - 'sessionrestore', 05:24:22 INFO - 'sessionrestore_no_auto_restore']}, 05:24:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['a11yr', 05:24:22 INFO - 'ts_paint', 05:24:22 INFO - 'tpaint', 05:24:22 INFO - 'sessionrestore', 05:24:22 INFO - 'sessionrestore_no_auto_restore']}, 05:24:22 INFO - 'other_l64': {'tests': ['a11yr', 05:24:22 INFO - 'ts_paint', 05:24:22 INFO - 'tpaint', 05:24:22 INFO - 'sessionrestore', 05:24:22 INFO - 'sessionrestore_no_auto_restore']}, 05:24:22 INFO - 'other_nol64': {'tests': ['a11yr', 05:24:22 INFO - 'ts_paint', 05:24:22 INFO - 'tpaint', 05:24:22 INFO - 'sessionrestore', 05:24:22 INFO - 'sessionrestore_no_auto_restore']}, 05:24:22 INFO - 'svgr': {'tests': ['tsvgx', 05:24:22 INFO - 'tsvgr_opacity', 05:24:22 INFO - 'tart', 05:24:22 INFO - 'tscrollx', 05:24:22 INFO - 'cart']}, 05:24:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['tsvgx', 05:24:22 INFO - 'tsvgr_opacity', 05:24:22 INFO - 'tart', 05:24:22 INFO - 'tscrollx', 05:24:22 INFO - 'cart']}, 05:24:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:22 INFO - 'tests': ['tp5o']}, 05:24:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:22 INFO - 'talos_options': ['--e10s'], 05:24:22 INFO - 'tests': ['tp5o']}, 05:24:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:22 INFO - 'talos_options': ['--xperf_path', 05:24:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:22 INFO - 'tests': ['tp5n']}, 05:24:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:22 INFO - 'talos_options': ['--e10s', 05:24:22 INFO - '--xperf_path', 05:24:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:22 INFO - 'tests': ['tp5n']}}, 05:24:22 INFO - 'talos.zip': {'path': '', 05:24:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:22 INFO - Running post-action listener: _resource_record_post_action 05:24:22 INFO - ##### 05:24:22 INFO - ##### Running create-virtualenv step. 05:24:22 INFO - ##### 05:24:22 INFO - Running pre-action listener: _resource_record_pre_action 05:24:22 INFO - Running main action method: create_virtualenv 05:24:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:22 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 05:24:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:22 INFO - Using real prefix '/tools/python27' 05:24:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:25 INFO - Installing pip.................done. 05:24:25 INFO - Return code: 0 05:24:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:26 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')]} 05:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:26 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 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:26 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 05:24:26 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 05:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:26 INFO - 'HOME': '/Users/cltbld', 05:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:26 INFO - 'LOGNAME': 'cltbld', 05:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:26 INFO - 'MOZ_NO_REMOTE': '1', 05:24:26 INFO - 'NO_EM_RESTART': '1', 05:24:26 INFO - 'PAGER': '/bin/cat', 05:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:26 INFO - 'PWD': '/builds/slave/test', 05:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:26 INFO - 'SHELL': '/bin/bash', 05:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:26 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:26 INFO - 'USER': 'cltbld', 05:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:26 INFO - 'XPC_FLAGS': '0x0', 05:24:26 INFO - 'XPC_SERVICE_NAME': '0', 05:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:26 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 05:24:26 INFO - Cleaning up... 05:24:26 INFO - Return code: 0 05:24:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:24:26 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')]} 05:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:26 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')]} 05:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:26 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 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:26 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 05:24:26 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 05:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:26 INFO - 'HOME': '/Users/cltbld', 05:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:26 INFO - 'LOGNAME': 'cltbld', 05:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:26 INFO - 'MOZ_NO_REMOTE': '1', 05:24:26 INFO - 'NO_EM_RESTART': '1', 05:24:26 INFO - 'PAGER': '/bin/cat', 05:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:26 INFO - 'PWD': '/builds/slave/test', 05:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:26 INFO - 'SHELL': '/bin/bash', 05:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:26 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:26 INFO - 'USER': 'cltbld', 05:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:26 INFO - 'XPC_FLAGS': '0x0', 05:24:26 INFO - 'XPC_SERVICE_NAME': '0', 05:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:26 INFO - Downloading/unpacking psutil>=0.7.1 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:29 INFO - Installing collected packages: psutil 05:24:29 INFO - Running setup.py install for psutil 05:24:29 INFO - building 'psutil._psutil_osx' extension 05:24:29 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 05:24:29 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 05:24:29 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 05:24:30 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 05:24:30 INFO - building 'psutil._psutil_posix' extension 05:24:30 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 05:24:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:24:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:24:30 INFO - ^ 05:24:30 INFO - 1 warning generated. 05:24:30 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 05:24:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:30 INFO - Successfully installed psutil 05:24:30 INFO - Cleaning up... 05:24:30 INFO - Return code: 0 05:24:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:30 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 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:30 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 05:24:30 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 05:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:30 INFO - 'HOME': '/Users/cltbld', 05:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:30 INFO - 'LOGNAME': 'cltbld', 05:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:30 INFO - 'MOZ_NO_REMOTE': '1', 05:24:30 INFO - 'NO_EM_RESTART': '1', 05:24:30 INFO - 'PAGER': '/bin/cat', 05:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:30 INFO - 'PWD': '/builds/slave/test', 05:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:30 INFO - 'SHELL': '/bin/bash', 05:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:30 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:30 INFO - 'USER': 'cltbld', 05:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:30 INFO - 'XPC_FLAGS': '0x0', 05:24:30 INFO - 'XPC_SERVICE_NAME': '0', 05:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:24:33 INFO - Installing collected packages: mozsystemmonitor 05:24:33 INFO - Running setup.py install for mozsystemmonitor 05:24:33 INFO - Successfully installed mozsystemmonitor 05:24:33 INFO - Cleaning up... 05:24:33 INFO - Return code: 0 05:24:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:33 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 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:33 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 05:24:33 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 05:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:33 INFO - 'HOME': '/Users/cltbld', 05:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:33 INFO - 'LOGNAME': 'cltbld', 05:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:33 INFO - 'MOZ_NO_REMOTE': '1', 05:24:33 INFO - 'NO_EM_RESTART': '1', 05:24:33 INFO - 'PAGER': '/bin/cat', 05:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:33 INFO - 'PWD': '/builds/slave/test', 05:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:33 INFO - 'SHELL': '/bin/bash', 05:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:33 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:33 INFO - 'USER': 'cltbld', 05:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:33 INFO - 'XPC_FLAGS': '0x0', 05:24:33 INFO - 'XPC_SERVICE_NAME': '0', 05:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:33 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 05:24:33 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 05:24:33 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 05:24:33 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 05:24:33 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 05:24:33 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 05:24:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:36 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 05:24:36 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 05:24:36 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 05:24:36 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 05:24:36 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 05:24:36 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 05:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:36 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 05:24:36 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 05:24:36 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 05:24:36 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 05:24:36 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 05:24:36 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 05:24:37 INFO - Downloading docopt-0.6.1.tar.gz 05:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:37 INFO - Running setup.py install for blobuploader 05:24:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:37 INFO - Running setup.py install for requests 05:24:37 INFO - Running setup.py install for docopt 05:24:38 INFO - Successfully installed blobuploader requests docopt 05:24:38 INFO - Cleaning up... 05:24:38 INFO - Return code: 0 05:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:38 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 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:38 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 05:24:38 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 05:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:38 INFO - 'HOME': '/Users/cltbld', 05:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:38 INFO - 'LOGNAME': 'cltbld', 05:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:38 INFO - 'MOZ_NO_REMOTE': '1', 05:24:38 INFO - 'NO_EM_RESTART': '1', 05:24:38 INFO - 'PAGER': '/bin/cat', 05:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:38 INFO - 'PWD': '/builds/slave/test', 05:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:38 INFO - 'SHELL': '/bin/bash', 05:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:38 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:38 INFO - 'USER': 'cltbld', 05:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:38 INFO - 'XPC_FLAGS': '0x0', 05:24:38 INFO - 'XPC_SERVICE_NAME': '0', 05:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:38 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-3zPlKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:38 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-xGcXFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:38 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-TKAdpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:38 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-a4Qmwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:38 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Vgz6j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:38 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-SjmS2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-GjNiuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Aa60hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-8i0BZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Ys0YEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-QI9ORC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-N4S7HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-eDgaPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-RQpmP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:39 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-S1PX3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:40 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-DW2hme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:40 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-nVCtyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:40 INFO - Running setup.py install for manifestparser 05:24:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:40 INFO - Running setup.py install for mozcrash 05:24:40 INFO - Running setup.py install for mozdebug 05:24:40 INFO - Running setup.py install for mozdevice 05:24:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:40 INFO - Running setup.py install for mozfile 05:24:40 INFO - Running setup.py install for mozhttpd 05:24:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:41 INFO - Running setup.py install for mozinfo 05:24:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:41 INFO - Running setup.py install for mozInstall 05:24:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:41 INFO - Running setup.py install for mozleak 05:24:41 INFO - Running setup.py install for mozlog 05:24:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:41 INFO - Running setup.py install for moznetwork 05:24:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:41 INFO - Running setup.py install for mozprocess 05:24:41 INFO - Running setup.py install for mozprofile 05:24:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Running setup.py install for mozrunner 05:24:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Running setup.py install for mozscreenshot 05:24:42 INFO - Running setup.py install for moztest 05:24:42 INFO - Running setup.py install for mozversion 05:24:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:42 INFO - Cleaning up... 05:24:42 INFO - Return code: 0 05:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:42 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 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:42 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 05:24:42 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 05:24:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:42 INFO - 'HOME': '/Users/cltbld', 05:24:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:42 INFO - 'LOGNAME': 'cltbld', 05:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:42 INFO - 'MOZ_NO_REMOTE': '1', 05:24:42 INFO - 'NO_EM_RESTART': '1', 05:24:42 INFO - 'PAGER': '/bin/cat', 05:24:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:42 INFO - 'PWD': '/builds/slave/test', 05:24:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:42 INFO - 'SHELL': '/bin/bash', 05:24:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:42 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:42 INFO - 'USER': 'cltbld', 05:24:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:42 INFO - 'XPC_FLAGS': '0x0', 05:24:42 INFO - 'XPC_SERVICE_NAME': '0', 05:24:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-1iuts1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-VinN1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-3ysrwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-PISwa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-oFOciA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-I6BV5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-bjrWre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-_cHJop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-bYFl02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:43 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)) 05:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:43 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-n1vMdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-DwoyPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-CTzcX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-RWOsiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-25Onwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-mQnQyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-K6pYvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:44 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)) 05:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-POQ1Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:44 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)) 05:24:44 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)) 05:24:44 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)) 05:24:44 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)) 05:24:44 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)) 05:24:44 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)) 05:24:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:44 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 05:24:47 INFO - Downloading blessings-1.6.tar.gz 05:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:47 INFO - Installing collected packages: blessings 05:24:47 INFO - Running setup.py install for blessings 05:24:47 INFO - Successfully installed blessings 05:24:47 INFO - Cleaning up... 05:24:47 INFO - Return code: 0 05:24:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:47 INFO - Reading from file tmpfile_stdout 05:24:47 INFO - Current package versions: 05:24:47 INFO - blessings == 1.6 05:24:47 INFO - blobuploader == 1.2.4 05:24:47 INFO - docopt == 0.6.1 05:24:47 INFO - manifestparser == 1.1 05:24:47 INFO - mozInstall == 1.12 05:24:47 INFO - mozcrash == 0.16 05:24:47 INFO - mozdebug == 0.1 05:24:47 INFO - mozdevice == 0.48 05:24:47 INFO - mozfile == 1.2 05:24:47 INFO - mozhttpd == 0.7 05:24:47 INFO - mozinfo == 0.9 05:24:47 INFO - mozleak == 0.1 05:24:47 INFO - mozlog == 3.1 05:24:47 INFO - moznetwork == 0.27 05:24:47 INFO - mozprocess == 0.22 05:24:47 INFO - mozprofile == 0.28 05:24:47 INFO - mozrunner == 6.11 05:24:47 INFO - mozscreenshot == 0.1 05:24:47 INFO - mozsystemmonitor == 0.0 05:24:47 INFO - moztest == 0.7 05:24:47 INFO - mozversion == 1.4 05:24:47 INFO - psutil == 3.1.1 05:24:47 INFO - requests == 1.2.3 05:24:47 INFO - wsgiref == 0.1.2 05:24:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:47 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')]} 05:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:47 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')]} 05:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:47 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 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:47 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 05:24:47 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 05:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:47 INFO - 'HOME': '/Users/cltbld', 05:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:47 INFO - 'LOGNAME': 'cltbld', 05:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:47 INFO - 'MOZ_NO_REMOTE': '1', 05:24:47 INFO - 'NO_EM_RESTART': '1', 05:24:47 INFO - 'PAGER': '/bin/cat', 05:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:47 INFO - 'PWD': '/builds/slave/test', 05:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:47 INFO - 'SHELL': '/bin/bash', 05:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:47 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:47 INFO - 'USER': 'cltbld', 05:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:47 INFO - 'XPC_FLAGS': '0x0', 05:24:47 INFO - 'XPC_SERVICE_NAME': '0', 05:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 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)) 05:24:48 INFO - Cleaning up... 05:24:48 INFO - Return code: 0 05:24:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:48 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')]} 05:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:48 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')]} 05:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:48 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 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:48 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 05:24:48 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 05:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:48 INFO - 'HOME': '/Users/cltbld', 05:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:48 INFO - 'LOGNAME': 'cltbld', 05:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:48 INFO - 'MOZ_NO_REMOTE': '1', 05:24:48 INFO - 'NO_EM_RESTART': '1', 05:24:48 INFO - 'PAGER': '/bin/cat', 05:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:48 INFO - 'PWD': '/builds/slave/test', 05:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:48 INFO - 'SHELL': '/bin/bash', 05:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:48 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:48 INFO - 'USER': 'cltbld', 05:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:48 INFO - 'XPC_FLAGS': '0x0', 05:24:48 INFO - 'XPC_SERVICE_NAME': '0', 05:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:48 INFO - Downloading/unpacking jsonschema 05:24:48 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 05:24:48 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 05:24:48 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 05:24:48 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 05:24:48 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 05:24:48 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 05:24:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:50 INFO - Downloading/unpacking functools32 (from jsonschema) 05:24:50 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 05:24:50 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 05:24:50 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 05:24:50 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 05:24:50 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 05:24:50 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 05:24:50 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:51 INFO - warning: no files found matching '*.txt' 05:24:51 INFO - no previously-included directories found matching 'build' 05:24:51 INFO - no previously-included directories found matching 'dist' 05:24:51 INFO - no previously-included directories found matching '.git*' 05:24:51 INFO - Installing collected packages: jsonschema, functools32 05:24:51 INFO - Running setup.py install for functools32 05:24:51 INFO - warning: no files found matching '*.txt' 05:24:51 INFO - no previously-included directories found matching 'build' 05:24:51 INFO - no previously-included directories found matching 'dist' 05:24:51 INFO - no previously-included directories found matching '.git*' 05:24:51 INFO - Successfully installed jsonschema functools32 05:24:51 INFO - Cleaning up... 05:24:51 INFO - Return code: 0 05:24:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5859ea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, '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.QogwgOAOaK/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.6gz1rxwSyu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 05:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:51 INFO - 'HOME': '/Users/cltbld', 05:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:51 INFO - 'LOGNAME': 'cltbld', 05:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:51 INFO - 'MOZ_NO_REMOTE': '1', 05:24:51 INFO - 'NO_EM_RESTART': '1', 05:24:51 INFO - 'PAGER': '/bin/cat', 05:24:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:51 INFO - 'PWD': '/builds/slave/test', 05:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:51 INFO - 'SHELL': '/bin/bash', 05:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:24:51 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:51 INFO - 'USER': 'cltbld', 05:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:51 INFO - 'XPC_FLAGS': '0x0', 05:24:51 INFO - 'XPC_SERVICE_NAME': '0', 05:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:51 INFO - Downloading/unpacking flake8 05:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:24:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:24:53 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 05:24:53 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 05:24:53 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 05:24:53 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 05:24:53 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 05:24:53 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 05:24:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:24:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:24:54 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 05:24:54 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 05:24:54 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 05:24:54 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 05:24:54 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 05:24:54 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 05:24:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:24:54 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 05:24:54 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 05:24:54 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 05:24:54 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 05:24:54 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 05:24:54 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 05:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:55 INFO - no previously-included directories found matching 'docs/_build' 05:24:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:24:55 INFO - Running setup.py install for pep8 05:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:55 INFO - no previously-included directories found matching 'docs/_build' 05:24:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:24:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:24:55 INFO - Cleaning up... 05:24:55 INFO - Return code: 0 05:24:55 INFO - Running post-action listener: _resource_record_post_action 05:24:55 INFO - Running post-action listener: _start_resource_monitoring 05:24:55 INFO - Starting resource monitoring. 05:24:55 INFO - ##### 05:24:55 INFO - ##### Running install step. 05:24:55 INFO - ##### 05:24:55 INFO - Running pre-action listener: _resource_record_pre_action 05:24:55 INFO - Running main action method: install 05:24:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:55 INFO - Reading from file tmpfile_stdout 05:24:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:55 INFO - Reading from file tmpfile_stdout 05:24:55 INFO - Output received: 05:24:55 INFO - Usage: mozinstall [options] installer 05:24:55 INFO - Options: 05:24:55 INFO - -h, --help show this help message and exit 05:24:55 INFO - -d DEST, --destination=DEST 05:24:55 INFO - Directory to install application into. [default: 05:24:55 INFO - "/builds/slave/test"] 05:24:55 INFO - --app=APP Application being installed. [default: firefox] 05:24:55 INFO - mkdir: /builds/slave/test/build/application 05:24:55 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'] 05:24:55 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 05:25:29 INFO - Reading from file tmpfile_stdout 05:25:29 INFO - Output received: 05:25:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:25:29 INFO - Running post-action listener: _resource_record_post_action 05:25:29 INFO - ##### 05:25:29 INFO - ##### Running run-tests step. 05:25:29 INFO - ##### 05:25:29 INFO - Running pre-action listener: _resource_record_pre_action 05:25:29 INFO - Running main action method: run_tests 05:25:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:25:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:25:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:25:29 INFO - 2016-02-15 05:25:29.854 screenresolution[1653:7567] starting screenresolution argv=screenresolution get 05:25:29 INFO - 2016-02-15 05:25:29.857 screenresolution[1653:7567] Display 0: 1600x1200x32@60 05:25:29 INFO - 2016-02-15 05:25:29.863 screenresolution[1654:7569] starting screenresolution argv=screenresolution list 05:25:29 INFO - Available Modes on Display 0 05:25:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:25:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:25:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:25:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:25:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:25:30 INFO - Intel Iris: 05:25:30 INFO - Chipset Model: Intel Iris 05:25:30 INFO - Type: GPU 05:25:30 INFO - Bus: Built-In 05:25:30 INFO - VRAM (Dynamic, Max): 1536 MB 05:25:30 INFO - Vendor: Intel (0x8086) 05:25:30 INFO - Device ID: 0x0a2e 05:25:30 INFO - Revision ID: 0x0009 05:25:30 INFO - Displays: 05:25:30 INFO - Display: 05:25:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:25:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:25:30 INFO - Display Serial Number: 1600x1200 60 05:25:30 INFO - Main Display: Yes 05:25:30 INFO - Mirror: Off 05:25:30 INFO - Online: Yes 05:25:30 INFO - Rotation: Supported 05:25:30 INFO - Return code: 0 05:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:30 INFO - Python 2.7.3 05:25:30 INFO - Return code: 0 05:25:30 INFO - grabbing minidump binary from tooltool 05:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:30 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 0x109a23d30>, '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 0x109847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a1ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:30 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 05:25:30 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 05:25:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:30 INFO - Return code: 0 05:25:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:25:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:25:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:25:31 INFO - Return code: 0 05:25:31 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/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--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 05:25:31 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/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0164 --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 05:25:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QogwgOAOaK/Render', 05:25:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:31 INFO - 'HOME': '/Users/cltbld', 05:25:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:31 INFO - 'LOGNAME': 'cltbld', 05:25:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:31 INFO - 'MOZ_NO_REMOTE': '1', 05:25:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:31 INFO - 'NO_EM_RESTART': '1', 05:25:31 INFO - 'PAGER': '/bin/cat', 05:25:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:31 INFO - 'PWD': '/builds/slave/test', 05:25:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:31 INFO - 'SHELL': '/bin/bash', 05:25:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gz1rxwSyu/Listeners', 05:25:31 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 05:25:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:31 INFO - 'USER': 'cltbld', 05:25:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:31 INFO - 'XPC_FLAGS': '0x0', 05:25:31 INFO - 'XPC_SERVICE_NAME': '0', 05:25:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:31 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/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--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 05:25:31 INFO - mozversion application_buildid: 20160215034121 05:25:31 INFO - mozversion application_changeset: fb1b8c571e954c651918fa22172ec69af05469fa 05:25:31 INFO - mozversion application_display_name: Nightly 05:25:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:31 INFO - mozversion application_name: Firefox 05:25:31 INFO - mozversion application_remotingname: firefox 05:25:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:25:31 INFO - mozversion application_vendor: Mozilla 05:25:31 INFO - mozversion application_version: 47.0a1 05:25:31 INFO - mozversion platform_buildid: 20160215034121 05:25:31 INFO - mozversion platform_changeset: fb1b8c571e954c651918fa22172ec69af05469fa 05:25:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:25:31 INFO - mozversion platform_version: 47.0a1 05:25:31 INFO - using testdate: 1455542731 05:25:31 INFO - actual date: 1455542731 05:25:32 INFO - starting webserver on 'localhost:49275' 05:25:32 INFO - SUITE-START | Running 2 tests 05:25:32 INFO - TEST-START | dromaeo_css 05:25:32 INFO - operating with platform_type : mac_ 05:25:32 INFO - Initialising browser for dromaeo_css test... 05:25:32 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpcX_abj/profile http://localhost:49275/getInfo.html) 05:25:34 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:25:34 INFO - PROCESS | 1672 | colorDepth:24 05:25:34 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:25:34 INFO - PROCESS | 1672 | __metrics 05:25:34 INFO - PROCESS | 1672 | 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" 05:25:34 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:35 INFO - TEST-INFO | 1672: exit 0 05:25:35 INFO - Browser initialized. 05:25:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:35 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpcX_abj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:47 INFO - PROCESS | 1675 | RSS: Main: 245800960 05:25:47 INFO - PROCESS | 1675 | 05:26:38 INFO - PROCESS | 1675 | 1455542798267 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] 05:28:47 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:28:50 INFO - PROCESS | 1675 | RSS: Main: 459825152 05:28:50 INFO - PROCESS | 1675 | 05:31:53 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:31:53 INFO - PROCESS | 1675 | RSS: Main: 380026880 05:31:53 INFO - PROCESS | 1675 | 05:34:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:34:56 INFO - PROCESS | 1675 | RSS: Main: 377618432 05:34:56 INFO - PROCESS | 1675 | 05:37:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:37:59 INFO - PROCESS | 1675 | RSS: Main: 376725504 05:37:59 INFO - PROCESS | 1675 | 05:41:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:41:02 INFO - PROCESS | 1675 | RSS: Main: 350715904 05:41:02 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:44:05 INFO - PROCESS | 1675 | RSS: Main: 433868800 05:44:05 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | __start_tp_report 05:44:05 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:44:05 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:44:05 INFO - PROCESS | 1675 | |i|pagename|runs| 05:44:05 INFO - PROCESS | 1675 | |0;dojo.html;3363.613184483784;3420.8631654733813;3446.879359222428;3458.4120699481095;3500.702440292575;5476.17857321402;5518.558515318775;5578.163275508676;5586.553075753935;5593.468620481053;5565.332160140779;5594.104943209088;5619.438056194378;5673.432656734335;5684.033714268574;5041.294218809369;5043.445221025684;5066.3920329560415;5086.237064440326;5151.072806894757;5126.512981266774;5131.563817075553;5191.402988656297;5193.740312984354;5244.292020577231;5072.061668591304;5082.1360368737405;5147.742612869341;5152.92270615941;5157.3811142662935;5132.923006154911;5137.922931156036;5156.20078887773;5177.042247184283;5186.844394668166;5073.847784566469;5087.491250874883;5127.435982041972;5128.461511541309;5137.717425541594;4541.886452838672;5436.510714035716;5474.37044739856;5526.58550608706;5546;6137.346341658241;6147.969260153715;6149.877002459926;6153.569250152491;6154.199954005995;6150.692465376758;6188.783392581238;6197.349278325801;6216.844578885519;6220.409061139185;5573.359063707644;5667.574931880125;5683.914741278884;5687.260656114679;5809.651420914759;6277.183966084471;6278.654673992883;6304.243490781044;6309.242890853127;6313.905291420632;5928.229330187134;5934.940650593525;5978.372270911578;5993.760249589967;5998.550108741774;6052.334243233241;6143.477804386588;6144.07838824171;6182.629042257479;6220.409061139185;6060.000099983454;6103.6104255942055;6109.01176576301;6116.061877111514;6129.481048574139;5954.642721436728;6107.83571684662;6118.649636126596;6140.289530736369;6151.446369826737;4804.327394164819;4813.4945830687975;4820.156472617278;4821.566059054702;4874.926876096862;4323.4379530661445;4334.50153232376;4341.761203133795;4375.971646663032;4393.626541743924;5487.122060470386;5554.416786237387;5564.276644036249;5564.916526252109;5565.9721701392045;6041.214642096499;6110.406879924458;6124.136831511461;6131.478824299896;6196.132541444202;5541.085720856014;5552.3892371839065;5565.332160140728;5566.2207290979295;5574.442555744474;5198.740062996835;5262.394824595144;5273.103572392626;5281.181416880389;5283.260343551906;6230.937690623035;6261.467775239155;6301.905471417932;6305.684715764193;6308.936910630835;6167.321594624498;6175.042868355412;6205.751769929333;6213.875722485615;6232.314445411092;6273.65494897785;6280.748770049329;6300.369963003663;6306;6308.400701933309;5919.437653422918;6011;6025.698715064317;6028.698565071817;6035.547333949883;6101.054336577838;6114.785982490592;6122.78570250057;6125.326214116354;6128.785492507741;5882.058870580687;5909.113632955091;5915.260592425947;5918.082697181943;5936.5844390892225;5729.312482502127;5890.7349169288345;5912.556558258062;5957.165996760544;6007.759689612367;5695.914561281501;5808.651480911159;5823.70881455934;5844.532437405082;5853.882922341444;5933.080372542263;5970.253718285215;5979.760809567742;6048.425399587032;6051.1830902829315;5773.162891380643;5815.156802263733;5819.738111785065;5837.67892765902;5876.559258055749 05:44:05 INFO - PROCESS | 1675 | |1;ext.html;439.20723094813866;449.4920739564292;463.11776066593154;534.9331333583302;561.0462214235799;39137.80431097844;39858.800705996466;39864.80067599665;39902.60097399025;39953.0011749706;31491.68508314916;31811.840940795322;31855.36289274213;42964;43676.344854827126;9389.436633801959;9590.520473976308;9616.08647178517;9617;9627.181689556395;8066.314363279128;9444.952775236114;9671.70984870455;9674.613015479372;9677.37097088687;8708.825823483527;8908.8663670045;9613.038696130401;9699.612015519371;11488.425578721073;11436.428178591037;11565.537378504807;11572.768544629145;11578.710532236677;11619.012383947374;11317.943410282896;11467.885321146765;11480.71298217543;11489.885101148966;11495.885041149566;38277;38577.03557411087;38581;38603.61396386028;38616;3148.984255078733;3406.403879321109;3704.462852886343;3748.137928276484;3972.245273398045;27904.720952790416;28791.56812647812;29355;29412.558811617844;29577.40845183106;2696.9730302696917;2769.806113572051;2793.7485626293733;2853.6432945881766;2859.571064340345;359270;362771.18614407023;365549.34450655687;365852;366107;65392.673036634515;65626;65642;65735;65742.67128664326;69748;70048;70075.64962175259;70085.29914700787;70347;16304.592385190464;16824.242909069122;16830.663386732198;16842.663146736995;16845.494635160965;12800.93599532015;12829.679258018625;12856.035797315239;12865.48538058486;12897.48410063587;16743.832561674226;16908.57728556796;20340.389788306078;20879.582408351747;21126.683099753514;7837.843243135219;7918.326942209977;8645.567721613894;8725.21473067427;8966.103389661112;886.4282537763106;955.7658373698488;986.8569057486624;1090.4711215060688;1109.1847492093304;28885.56671649927;29226.561601575995;29519.55720664192;29770.10689679313;29875;898.2409863665192;1010.8989101089833;1081.8377243413552;1088.7985722641338;1189.3171162804708;14774.556763297118;14832.925835370754;14835.554933352018;15184.848151518343;15201.695966080617;520465;528578;529015;529428;530159;56927.14609280864;57618.135727964116;57688.42311576915;57751.711241443525;57752.133717994264;1399.8110255115632;1413.5759272218293;1429.6711756296318;1434.3258668425824;1439.6904665496968;29225.97709080257;29868.253293667833;31086.22284442907;31088.378232435676;31745.20636984094;51689.48310516847;52461.21308180304;52464;52569.47430525646;52638.47361526489;457497;467541.66229168634;477458.86681897903;488447;512049;34060.659393405746;40601;41426;41564.960875978344;41964.790176048926;43318.8523893554;43383.13233735371;43811.561884380746;44709.55290447054;44810.77594612006;28785.30484109727;30911.845440772653;34942.82528587442;35134.94595162149;37066.25867482581;29743.553846691884;34819.82590087033;36018.4597231047;36100.63899361078;36459.635403645625;34992.9502114937;36093.819530902176;36145;36160.81919590385;36203.63796362003;30806.691933080383;31598.36803263876;31629.525557117122;31695.366092677556;31758.36483270368;17704.55738606545;20977.685334720296;23683.52632947297;25286.49427011486;25353.295508510437 05:44:05 INFO - PROCESS | 1675 | |2;jquery.html;315.7631776167874;367.0969415238513;372.89745320036997;373.23673088533945;374.8762908240281;16125.596860078489;18397.17212725427;18964.05179741011;18968.62062758744;19465.124069416874;14700.632484187874;18787.3424430145;19083.713744293847;19122.904385478087;19526.51183720404;5531.723413829312;5731.054376027951;5904.439078287556;5919.496842768348;5930.288365396137;5497.47773961473;5592.552595792326;5641.266635337421;5641.605087643867;5762.279715035621;3844.692424606039;4015.6185162409524;5633.15502674598;5755.798547050854;5770.307563092435;5768.134779783024;5835.241418615574;5838.824835254928;5842.678652674102;6040.728167232485;5485.341758988907;5633.943660563383;5642.605017648766;5647.152927060933;5651.982643124236;17504.474865754048;20543.945605439338;22436.43908902274;23055.193068242697;23100.19149329782;2108.125128071864;2166.967495487569;2395.38917576017;2457.8648174350405;2595.8312709674;9488.810223795554;9656.179224765903;9689.660861869801;9956.601735930553;13689;1708.7949446066427;1779.0482092080804;1787.4190887961336;1788.534980904974;1822.0161112999097;76376.61811690961;93294.53352733194;93485;93537.0646293542;94099.52950235273;10895.83656245157;10981.286216396069;11001.504932278067;11027.779444411068;11107.722306942229;13157.407916643773;13290.468381264642;13309.733805324033;13325.533606323732;13330.800037999437;7073.858522829618;8127.699568069199;8332.083470818205;8343.165683431609;8439.451435656663;8467.068622451525;8486.278666313432;8489.787755306043;8578.914210857936;8588.355873309401;4261.70168088237;4324.437823082979;4341.717788343748;4376.562343765598;4384.978075109668;1808.4303444414968;1841.7513635659016;1850.9722354164699;1855.2022630269114;1857.6934805756898;365.8682874165298;368.8690514867237;391.9333713268751;749.539033494397;920.6225447566466;9882.901170988342;11082.279651822606;11357.318560886373;11741.29552226869;11876.465559049864;442.26363105429743;451.17885448483446;458.99082018360116;465.56702266892114;487.4004973882074;4432.822687092545;5666.603337766317;5754.05058165398;6050.6672133032225;6229.56393052482;507744;512508;550082;560337;560723;113601.43199283951;116867.41566292114;117677;119056;121711.39144304399;1029.8414283930579;1114.5653195253858;1159.2291126401017;1161.8199179127248;1173.1318824070127;14962.251887405368;17528.474145775646;17714.5571360717;18055.458336249932;18117.637647246716;49867;50998.23502647389;51219.975600487036;51578.968420632125;51709.7414512925;69703.65148174227;75026;75674.24325756672;75754;75989.50917946796;7380.630968451448;7497.850042999;7501.924980750123;7516.962415187889;7584.127825300161;8402;10128.797424051625;11803.23278986863;12131.878681213075;12453.920890688632;9762.511874406393;10000.399976001172;10276.537555809857;10407.375557466576;10424.530896109542;10001.54993025301;10162.89837101649;10397.792044158923;10455.268131230741;10457.97159133336;10405.375677459377;10492.947535262274;10571.5242814072;10661.200409969439;10686.305390149615;7378.852422951618;7399.556026638419;7475.738349157753;7491.438142139253;7548.245175482408;8131.878021829795;10314.535845887103;10349.534270957674;10477.790444191225;10500.212484063879 05:44:05 INFO - PROCESS | 1675 | |3;mootools.html;1401.1032938919086;1522.1171720402167;1550.5193390049083;1778.164262796486;1933.719610656455;7818.17909119542;8391.748247552576;8468.280196183332;8470.534120623362;8472.83054338913;8229;8340.499570025788;8419.789505262355;8424.283935865458;8458.661653533867;2157.7302837145357;2208.0615738311235;2452.227548322277;2475.9133430329853;2476.938076548083;2009.2164056018164;2226.476777957179;2234.54191890662;2237.127520267097;2477.55404027275;2444.8166387521005;2447.2046584859904;2448.069733501267;2448.412381028549;2449.1428000199876;2387.9999999999914;2442.6091825308044;2444.8166387521005;2447.7919376852988;2451.460678650694;2398.604230301998;2443.9511209775883;2444.914427995029;2445.08309383981;2451.6445115458337;7433.739819106359;8112.31045361145;8531.445456045338;8705.738827835175;8746.912530874673;5285.947140528584;5446.183072539111;5449.945500544984;5454.809081682122;5459.071957767189;3040.19434849765;3597.9820100899587;3607.6753092221566;3607.693346065588;3716.2195938852874;1031.8968103189695;1036;1077.6389909380289;1079.1618044542881;1079.611339917629;11746.882531174664;11763.941180294129;11765.05879529627;11773.058155347551;11786.646400607995;4800.687955282895;4839.564439200489;4923.113839508851;4941.160002799533;4953.851384458472;10067.395956242648;10110.646127385506;10110.747231319276;10115;10136.847947280796;5430.538404235605;5459.099248623933;5465.988792073479;5471.398146203915;5471.562275017989;4364.039911219526;4787.018661174451;4924.8276310328965;4970.90058198834;4982.676126051868;3704.1850792825535;3715.3126671565306;3761.360568703327;3762.774233545941;3811.1996480739354;1131.598282609678;1138.317009794117;1184.9111316651286;1198.5804968261039;1199.1366216324232;1308.1039487950784;1308.6989992301824;1318.1036894911551;1344.0927374022497;1348.2854087333728;8017.037955445384;8084.676612935535;8130.878036829452;8136.34909207262;8138.064122625856;1104.8177050786692;1139.367650953712;1194.134252666827;1204.566356111799;1216.969575760613;6280.120783090371;6314.71583778731;6382.393672601095;6392.520560957947;6397.136386587844;10256.12822910061;10491.842622360671;10613;10622.840657390145;10639.840402393971;9830.557624906896;10449.84325235122;10474.214433917334;10475.214358923111;10482.63310784119;8109.270165685117;8244.010718713793;8313.418060735812;8317.8336433271;8319.251267385844;8003.999500062492;8005.479643823133;8107.878381824396;8110.878336824834;8139.633716482891;9512.762180945532;9565.521723913917;9584.520773961414;9637.518124093907;9759.804803904024;9835.60657573689;9895.25785566071;9979.45113018791;10110.241731869992;10134.543945522617;7450.0687414073245;7463.962680186564;7536.397088233038;7560.941468194567;7572.621368931421;7247.601381924045;8088.191180881865;8145.470544414594;8146.266835984789;8178.223068808454;6763.12079429671;7275.599842008529;7720.922790772021;7780.144184139854;7950.920490795018;7617.047869016373;7635.083789945242;7682.7311044113185;7727.652255648622;7751.37988960893;7775.300222979959;7834.764957051298;7837.6081195941115;7855.84288314242;7862.72480463181;6980.581165130108;7011.26381729911;7067.57594544329;7098.148222213367;7098.964505177441;6015.248093988252;7136.393406560501;7172.533785303938;7176.318249766264;7180.425565954815 05:44:05 INFO - PROCESS | 1675 | |4;prototype.html;315.6448994880759;321.18259030766694;327.3044779842834;328.81257683120623;332.1381016262797;6578.914479110941;6580.407763301302;6583.4074933256;6595.0437186607915;6666.4000239978395;6540.444062254702;6543.083968244449;6545.476361891049;6561.77033803817;6583.868322633544;4773.832915847946;4889.242167464049;4889.339939108219;4902.583280421169;4921.360223170983;4876.902461950759;4887.511248875119;4915.606751459874;4915.992221594564;4921.901561968776;4823.686460380081;4836.226203807391;4836.250381190921;4845.273209018657;4857.53853383928;4602;4687.835925742616;4728.83449079284;4835.419749630049;4855.854324370257;4070.9185816283803;4121.237571049365;4124.484439445069;4133.91732165355;4140.772257525835;6252.499800015988;6299.307076221612;6304.27500837405;6314.621122732605;6320.652364119972;5394.32570928634;5523.364813046511;5526.751296191681;5637.3517045539875;5663.5186009189265;6915.343042411013;6922.480813938924;6924.23833378328;6941.687624056879;6943.79168624942;4634.930476042862;4643.721376717408;4646.186917289495;4660.231061874787;4662.230731929228;5972.940270597282;7107.786766397016;7365.153007404164;7384.15082265541;7394.852102957964;4737.38414006177;4743.1225223333795;4744.905101898012;4746.857594272177;4752.904941901143;4819.746865814844;4821.807127714852;4836.081144582518;4840.104580652591;4844.539768721966;5316.362036555561;5681.517071049007;5682.886342273131;5686.317641882918;5690.886182276331;5605.467480589419;6943.72225111;6944.097267355211;6956.617386043817;7000.929990700028;1329.5346628679886;1401.4604377314806;1594.330381239882;1621.7161996650539;1625.2848746551479;1022.6778564752079;1033.844923261517;1037.1650821089095;1038.4496217004998;1054.4200689620677;6427.742890284337;6435;6435.646039467781;6452.903206451907;6472.741090356333;7157.498975071695;7167.713291468387;7170.641467926583;7172.928270717331;7193;5680.943190568041;5998.610090344114;6369.108324834527;6437.935620643827;6438.45273151778;3845.5193100862393;3878.495795546561;3878.7284890057426;3890.183061557048;3896.8246428910766;7632.389408847279;7638.770836874903;7657.34912532441;7662;7686.538807671557;7120.501564890408;7314.403386797717;7347.228541003117;7400.703971841173;7602.163761986177;7118.9644051779405;7588.924110758932;7599.772006839804;7682.6158692064055;7706.460547761603;7387.150477695134;7388.408927285696;7405.7778266652085;7407.62961851916;7428.554286742813;6981.406580440719;7251.057362542836;7266.1280646322775;7286.7085316586745;7292.270772922665;7652.464327497022;7687.961560192163;7691.961540192263;7692.499987500794;7705.653245604073;3793.2982398256413;4631.513691062525;4642.141203877159;4644.628429725682;4646.697964632288;7068.752593659197;7315.817104572216;7338.70645174187;7350.669219885225;7358.0434543509;7100.076989991268;7105.253948335557;7112.431005519649;7117.153138744544;7117.75087871922;6836.5214434989075;7086;7091.290870913073;7096.432285417258;7096.964515177391;6937.7224911002995;6938.653067346713;6942.51402401827;6950.443964482728;6956.860862782817;7082.362587367162;7090.893636595559;7096.858062838817;7109.857802844018;7121.216666166821;6770;6952;6964.338387853146;6968.895466568107;6987.441004719712 05:44:05 INFO - PROCESS | 1675 | |5;yui.html;680.8740383029143;685.4242436353463;701.884189108797;713.2012146396037;736.329939754823;14523.709525809478;14835.703285934289;17101.31594736209;17410.95534267945;17418.738718919227;15763.21183940804;15851.841481585181;15855.445059422922;15863.682726345467;15864.682706345866;717.125107369009;726.4696771356913;859.9613017414216;871.4988881393192;884.3588398411165;870.1211776106115;873.5457562067721;881.7531091294447;881.8985816631106;883.4434306386967;918.17364372065;920.5949382271813;921.4517362169498;922.7324076017946;924.3575714878162;737.4284929179875;749.3929916767381;903.3586153830788;914.0950459045497;917.5045475443253;683.9658017099175;684.5105749389161;684.7295318349225;685.766839274649;689.1454596300601;14909.403623855032;14917.925410372987;14960;14988.850111498854;15101.32044058009;12135.817962730565;12207.511699532008;12267.202631828992;12549.560765373168;12758.936205319007;8257.504549726975;10158.746031349201;10196.949015254877;10245.129164021067;10897.67306980792;3485.4597537381746;3495.8601655933985;3544.787312761217;3561.2343346180437;3609.855605775766;75015.87476187861;75595.62202189009;76629.85055224175;84202.73695894566;84913;9349.15857572808;9391.718248452557;9443.961164271925;9485;9614.942356340796;19843.40469785909;19847.503812404517;19876.801231987494;19883.30408435698;19919.302824401075;7276.417886569062;7404.370628496638;7414.814629634195;7522.172561018284;7641.044869391326;4134.255833949857;4172.77049762266;4188.790560471964;4192.790360481964;4239.1521695660995;3504.3166582516164;3550.840212190458;3557.7153827693724;3563.94654080189;3566.0728210665416;566.0462121325497;572.4418691775486;581.880714453536;668.4919461209419;699.646678427391;560.025555533369;572.2960758267354;602.7197353230681;619.5508256514081;635.9046143078575;8322.62548185333;8371.576831938584;8449.089649466468;8739.21347078766;8809.33929955256;524.307913554105;551.4705882352906;596.7463827873223;604.5767962426319;615.9876802464015;3864.729468937204;4009.4386785850006;4081;4122.216778812076;4123.257813593582;93051.53474232585;93658;95164.52417738005;95172.52413737887;95459;65104.023439648445;85027.87430314168;85375;85442;86163.56918215494;59558.70220648869;60857;61025.084623730676;61237;62401.68799156066;8050.355971522147;8110.675572977015;8183;8325.626271665107;8329.708460203863;49510.75244623754;49624;50228.748856255486;50445;50470.74764626153;68950.965735513;70953.64523177351;71548.3493572916;72862;77359.61320193364;9766.316357854881;9833.85249221248;9959.950200249243;10009.449480278654;10460.68617941463;11907.191472077031;12013.45939432745;12441.93779031099;12586.87413125857;12806.679833003876;11219.831702524305;11221.55113795439;11264.549418023515;11422.714432139262;12028.458719357475;11141.997220250216;11527;11650.88349116498;12171.756903436279;12183.380573176455;10291.279610427198;11021.118310534977;11035.062019728091;11263.774724505627;11847.703807404883;8879.733607991771;8918;9061.592228349607;9082.682106126254;9761.170300524534;9075.410098343587;9495.14543691071;10006.899931000597;10036.498175091363;10039.34744241622 05:44:05 INFO - PROCESS | 1675 | __end_tp_report 05:44:05 INFO - PROCESS | 1675 | __start_cc_report 05:44:05 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,2592 05:44:05 INFO - PROCESS | 1675 | __end_cc_report 05:44:05 INFO - PROCESS | 1675 | __startTimestamp1455543845814__endTimestamp 05:44:05 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:44:05 INFO - PROCESS | 1675 | Number of tests: 6 05:44:05 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5642.71 Median:5837.68 stddev:625.06 (10.7%) stddev-sans-first:600.86 05:44:05 INFO - PROCESS | 1675 | Values: 3363.6 3420.9 3446.9 3458.4 3500.7 5476.2 5518.6 5578.2 5586.6 5593.5 5565.3 5594.1 5619.4 5673.4 5684.0 5041.3 5043.4 5066.4 5086.2 5151.1 5126.5 5131.6 5191.4 5193.7 5244.3 5072.1 5082.1 5147.7 5152.9 5157.4 5132.9 5137.9 5156.2 5177.0 5186.8 5073.8 5087.5 5127.4 5128.5 5137.7 4541.9 5436.5 5474.4 5526.6 5546.0 6137.3 6148.0 6149.9 6153.6 6154.2 6150.7 6188.8 6197.3 6216.8 6220.4 5573.4 5667.6 5683.9 5687.3 5809.7 6277.2 6278.7 6304.2 6309.2 6313.9 5928.2 5934.9 5978.4 5993.8 5998.6 6052.3 6143.5 6144.1 6182.6 6220.4 6060.0 6103.6 6109.0 6116.1 6129.5 5954.6 6107.8 6118.6 6140.3 6151.4 4804.3 4813.5 4820.2 4821.6 4874.9 4323.4 4334.5 4341.8 4376.0 4393.6 5487.1 5554.4 5564.3 5564.9 5566.0 6041.2 6110.4 6124.1 6131.5 6196.1 5541.1 5552.4 5565.3 5566.2 5574.4 5198.7 5262.4 5273.1 5281.2 5283.3 6230.9 6261.5 6301.9 6305.7 6308.9 6167.3 6175.0 6205.8 6213.9 6232.3 6273.7 6280.7 6300.4 6306.0 6308.4 5919.4 6011.0 6025.7 6028.7 6035.5 6101.1 6114.8 6122.8 6125.3 6128.8 5882.1 5909.1 5915.3 5918.1 5936.6 5729.3 5890.7 5912.6 5957.2 6007.8 5695.9 5808.7 5823.7 5844.5 5853.9 5933.1 5970.3 5979.8 6048.4 6051.2 5773.2 5815.2 5819.7 5837.7 5876.6 05:44:05 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:61038.18 Median:36182.23 stddev:122886.81 (339.6%) stddev-sans-first:123147.31 05:44:05 INFO - PROCESS | 1675 | Values: 439.2 449.5 463.1 534.9 561.0 39137.8 39858.8 39864.8 39902.6 39953.0 31491.7 31811.8 31855.4 42964.0 43676.3 9389.4 9590.5 9616.1 9617.0 9627.2 8066.3 9445.0 9671.7 9674.6 9677.4 8708.8 8908.9 9613.0 9699.6 11488.4 11436.4 11565.5 11572.8 11578.7 11619.0 11317.9 11467.9 11480.7 11489.9 11495.9 38277.0 38577.0 38581.0 38603.6 38616.0 3149.0 3406.4 3704.5 3748.1 3972.2 27904.7 28791.6 29355.0 29412.6 29577.4 2697.0 2769.8 2793.7 2853.6 2859.6 359270.0 362771.2 365549.3 365852.0 366107.0 65392.7 65626.0 65642.0 65735.0 65742.7 69748.0 70048.0 70075.6 70085.3 70347.0 16304.6 16824.2 16830.7 16842.7 16845.5 12800.9 12829.7 12856.0 12865.5 12897.5 16743.8 16908.6 20340.4 20879.6 21126.7 7837.8 7918.3 8645.6 8725.2 8966.1 886.4 955.8 986.9 1090.5 1109.2 28885.6 29226.6 29519.6 29770.1 29875.0 898.2 1010.9 1081.8 1088.8 1189.3 14774.6 14832.9 14835.6 15184.8 15201.7 520465.0 528578.0 529015.0 529428.0 530159.0 56927.1 57618.1 57688.4 57751.7 57752.1 1399.8 1413.6 1429.7 1434.3 1439.7 29226.0 29868.3 31086.2 31088.4 31745.2 51689.5 52461.2 52464.0 52569.5 52638.5 457497.0 467541.7 477458.9 488447.0 512049.0 34060.7 40601.0 41426.0 41565.0 41964.8 43318.9 43383.1 43811.6 44709.6 44810.8 28785.3 30911.8 34942.8 35134.9 37066.3 29743.6 34819.8 36018.5 36100.6 36459.6 34993.0 36093.8 36145.0 36160.8 36203.6 30806.7 31598.4 31629.5 31695.4 31758.4 17704.6 20977.7 23683.5 25286.5 25353.3 05:44:05 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:31188.56 Median:2203.78 stddev:89765.06 (4073.2%) stddev-sans-first:89986.94 05:44:05 INFO - PROCESS | 1675 | Values: 315.8 367.1 372.9 373.2 374.9 16125.6 18397.2 18964.1 18968.6 19465.1 14700.6 18787.3 19083.7 19122.9 19526.5 5531.7 5731.1 5904.4 5919.5 5930.3 5497.5 5592.6 5641.3 5641.6 5762.3 3844.7 4015.6 5633.2 5755.8 5770.3 5768.1 5835.2 5838.8 5842.7 6040.7 5485.3 5633.9 5642.6 5647.2 5652.0 17504.5 20543.9 22436.4 23055.2 23100.2 2108.1 2167.0 2395.4 2457.9 2595.8 9488.8 9656.2 9689.7 9956.6 13689.0 1708.8 1779.0 1787.4 1788.5 1822.0 76376.6 93294.5 93485.0 93537.1 94099.5 10895.8 10981.3 11001.5 11027.8 11107.7 13157.4 13290.5 13309.7 13325.5 13330.8 7073.9 8127.7 8332.1 8343.2 8439.5 8467.1 8486.3 8489.8 8578.9 8588.4 4261.7 4324.4 4341.7 4376.6 4385.0 1808.4 1841.8 1851.0 1855.2 1857.7 365.9 368.9 391.9 749.5 920.6 9882.9 11082.3 11357.3 11741.3 11876.5 442.3 451.2 459.0 465.6 487.4 4432.8 5666.6 5754.1 6050.7 6229.6 507744.0 512508.0 550082.0 560337.0 560723.0 113601.4 116867.4 117677.0 119056.0 121711.4 1029.8 1114.6 1159.2 1161.8 1173.1 14962.3 17528.5 17714.6 18055.5 18117.6 49867.0 50998.2 51220.0 51579.0 51709.7 69703.7 75026.0 75674.2 75754.0 75989.5 7380.6 7497.9 7501.9 7517.0 7584.1 8402.0 10128.8 11803.2 12131.9 12453.9 9762.5 10000.4 10276.5 10407.4 10424.5 10001.5 10162.9 10397.8 10455.3 10458.0 10405.4 10492.9 10571.5 10661.2 10686.3 7378.9 7399.6 7475.7 7491.4 7548.2 8131.9 10314.5 10349.5 10477.8 10500.2 05:44:05 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:6020.47 Median:5134.31 stddev:3164.00 (61.6%) stddev-sans-first:3153.82 05:44:05 INFO - PROCESS | 1675 | Values: 1401.1 1522.1 1550.5 1778.2 1933.7 7818.2 8391.7 8468.3 8470.5 8472.8 8229.0 8340.5 8419.8 8424.3 8458.7 2157.7 2208.1 2452.2 2475.9 2476.9 2009.2 2226.5 2234.5 2237.1 2477.6 2444.8 2447.2 2448.1 2448.4 2449.1 2388.0 2442.6 2444.8 2447.8 2451.5 2398.6 2444.0 2444.9 2445.1 2451.6 7433.7 8112.3 8531.4 8705.7 8746.9 5285.9 5446.2 5449.9 5454.8 5459.1 3040.2 3598.0 3607.7 3607.7 3716.2 1031.9 1036.0 1077.6 1079.2 1079.6 11746.9 11763.9 11765.1 11773.1 11786.6 4800.7 4839.6 4923.1 4941.2 4953.9 10067.4 10110.6 10110.7 10115.0 10136.8 5430.5 5459.1 5466.0 5471.4 5471.6 4364.0 4787.0 4924.8 4970.9 4982.7 3704.2 3715.3 3761.4 3762.8 3811.2 1131.6 1138.3 1184.9 1198.6 1199.1 1308.1 1308.7 1318.1 1344.1 1348.3 8017.0 8084.7 8130.9 8136.3 8138.1 1104.8 1139.4 1194.1 1204.6 1217.0 6280.1 6314.7 6382.4 6392.5 6397.1 10256.1 10491.8 10613.0 10622.8 10639.8 9830.6 10449.8 10474.2 10475.2 10482.6 8109.3 8244.0 8313.4 8317.8 8319.3 8004.0 8005.5 8107.9 8110.9 8139.6 9512.8 9565.5 9584.5 9637.5 9759.8 9835.6 9895.3 9979.5 10110.2 10134.5 7450.1 7464.0 7536.4 7560.9 7572.6 7247.6 8088.2 8145.5 8146.3 8178.2 6763.1 7275.6 7720.9 7780.1 7950.9 7617.0 7635.1 7682.7 7727.7 7751.4 7775.3 7834.8 7837.6 7855.8 7862.7 6980.6 7011.3 7067.6 7098.1 7099.0 6015.2 7136.4 7172.5 7176.3 7180.4 05:44:05 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5757.86 Median:6462.82 stddev:1843.66 (28.5%) stddev-sans-first:1803.01 05:44:05 INFO - PROCESS | 1675 | Values: 315.6 321.2 327.3 328.8 332.1 6578.9 6580.4 6583.4 6595.0 6666.4 6540.4 6543.1 6545.5 6561.8 6583.9 4773.8 4889.2 4889.3 4902.6 4921.4 4876.9 4887.5 4915.6 4916.0 4921.9 4823.7 4836.2 4836.3 4845.3 4857.5 4602.0 4687.8 4728.8 4835.4 4855.9 4070.9 4121.2 4124.5 4133.9 4140.8 6252.5 6299.3 6304.3 6314.6 6320.7 5394.3 5523.4 5526.8 5637.4 5663.5 6915.3 6922.5 6924.2 6941.7 6943.8 4634.9 4643.7 4646.2 4660.2 4662.2 5972.9 7107.8 7365.2 7384.2 7394.9 4737.4 4743.1 4744.9 4746.9 4752.9 4819.7 4821.8 4836.1 4840.1 4844.5 5316.4 5681.5 5682.9 5686.3 5690.9 5605.5 6943.7 6944.1 6956.6 7000.9 1329.5 1401.5 1594.3 1621.7 1625.3 1022.7 1033.8 1037.2 1038.4 1054.4 6427.7 6435.0 6435.6 6452.9 6472.7 7157.5 7167.7 7170.6 7172.9 7193.0 5680.9 5998.6 6369.1 6437.9 6438.5 3845.5 3878.5 3878.7 3890.2 3896.8 7632.4 7638.8 7657.3 7662.0 7686.5 7120.5 7314.4 7347.2 7400.7 7602.2 7119.0 7588.9 7599.8 7682.6 7706.5 7387.2 7388.4 7405.8 7407.6 7428.6 6981.4 7251.1 7266.1 7286.7 7292.3 7652.5 7688.0 7692.0 7692.5 7705.7 3793.3 4631.5 4642.1 4644.6 4646.7 7068.8 7315.8 7338.7 7350.7 7358.0 7100.1 7105.3 7112.4 7117.2 7117.8 6836.5 7086.0 7091.3 7096.4 7097.0 6937.7 6938.7 6942.5 6950.4 6956.9 7082.4 7090.9 7096.9 7109.9 7121.2 6770.0 6952.0 6964.3 6968.9 6987.4 05:44:05 INFO - PROCESS | 1675 | 05:44:05 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:18304.75 Median:60941.04 stddev:25837.88 (42.4%) stddev-sans-first:25876.47 05:44:05 INFO - PROCESS | 1675 | Values: 680.9 685.4 701.9 713.2 736.3 14523.7 14835.7 17101.3 17411.0 17418.7 15763.2 15851.8 15855.4 15863.7 15864.7 717.1 726.5 860.0 871.5 884.4 870.1 873.5 881.8 881.9 883.4 918.2 920.6 921.5 922.7 924.4 737.4 749.4 903.4 914.1 917.5 684.0 684.5 684.7 685.8 689.1 14909.4 14917.9 14960.0 14988.9 15101.3 12135.8 12207.5 12267.2 12549.6 12758.9 8257.5 10158.7 10196.9 10245.1 10897.7 3485.5 3495.9 3544.8 3561.2 3609.9 75015.9 75595.6 76629.9 84202.7 84913.0 9349.2 9391.7 9444.0 9485.0 9614.9 19843.4 19847.5 19876.8 19883.3 19919.3 7276.4 7404.4 7414.8 7522.2 7641.0 4134.3 4172.8 4188.8 4192.8 4239.2 3504.3 3550.8 3557.7 3563.9 3566.1 566.0 572.4 581.9 668.5 699.6 560.0 572.3 602.7 619.6 635.9 8322.6 8371.6 8449.1 8739.2 8809.3 524.3 551.5 596.7 604.6 616.0 3864.7 4009.4 4081.0 4122.2 4123.3 93051.5 93658.0 95164.5 95172.5 95459.0 65104.0 85027.9 85375.0 85442.0 86163.6 59558.7 60857.0 61025.1 61237.0 62401.7 8050.4 8110.7 8183.0 8325.6 8329.7 49510.8 49624.0 50228.7 50445.0 50470.7 68951.0 70953.6 71548.3 72862.0 77359.6 9766.3 9833.9 9960.0 10009.4 10460.7 11907.2 12013.5 12441.9 12586.9 12806.7 11219.8 11221.6 11264.5 11422.7 12028.5 11142.0 11527.0 11650.9 12171.8 12183.4 10291.3 11021.1 11035.1 11263.8 11847.7 8879.7 8918.0 9061.6 9082.7 9761.2 9075.4 9495.1 10006.9 10036.5 10039.3 05:44:05 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:44:05 INFO - PROCESS | 1675 | 05:44:06 INFO - TEST-INFO | 1675: exit 0 05:44:06 INFO - TEST-OK | dromaeo_css | took 1114182ms 05:44:06 INFO - TEST-START | kraken 05:44:06 INFO - operating with platform_type : mac_ 05:44:06 INFO - Initialising browser for kraken test... 05:44:06 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmp_Ao53A/profile http://localhost:49275/getInfo.html) 05:44:08 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 05:44:08 INFO - PROCESS | 1682 | colorDepth:24 05:44:08 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 05:44:08 INFO - PROCESS | 1682 | __metrics 05:44:08 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" 05:44:08 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] 05:44:09 INFO - TEST-INFO | 1682: exit 0 05:44:09 INFO - Browser initialized. 05:44:09 INFO - Running cycle 1/1 for kraken test... 05:44:09 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmp_Ao53A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:21 INFO - PROCESS | 1684 | RSS: Main: 245878784 05:44:21 INFO - PROCESS | 1684 | 05:44:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:24 INFO - PROCESS | 1684 | RSS: Main: 290906112 05:44:24 INFO - PROCESS | 1684 | 05:44:27 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:44:27 INFO - PROCESS | 1684 | RSS: Main: 300695552 05:44:27 INFO - PROCESS | 1684 | 05:44:31 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:44:31 INFO - PROCESS | 1684 | RSS: Main: 289112064 05:44:31 INFO - PROCESS | 1684 | 05:44:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:44:34 INFO - PROCESS | 1684 | RSS: Main: 290902016 05:44:34 INFO - PROCESS | 1684 | 05:44:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:37 INFO - PROCESS | 1684 | RSS: Main: 292134912 05:44:37 INFO - PROCESS | 1684 | 05:44:39 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:44:40 INFO - PROCESS | 1684 | RSS: Main: 294019072 05:44:40 INFO - PROCESS | 1684 | 05:44:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:44:44 INFO - PROCESS | 1684 | RSS: Main: 293933056 05:44:44 INFO - PROCESS | 1684 | 05:44:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:44:47 INFO - PROCESS | 1684 | RSS: Main: 293486592 05:44:47 INFO - PROCESS | 1684 | 05:44:48 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:49 INFO - PROCESS | 1684 | RSS: Main: 325779456 05:44:49 INFO - PROCESS | 1684 | 05:44:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:51 INFO - PROCESS | 1684 | RSS: Main: 325328896 05:44:51 INFO - PROCESS | 1684 | 05:44:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:54 INFO - PROCESS | 1684 | RSS: Main: 333127680 05:44:54 INFO - PROCESS | 1684 | 05:44:57 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:57 INFO - PROCESS | 1684 | RSS: Main: 333811712 05:44:57 INFO - PROCESS | 1684 | 05:45:00 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:00 INFO - PROCESS | 1684 | RSS: Main: 334016512 05:45:00 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:45:02 INFO - PROCESS | 1684 | RSS: Main: 394248192 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | __start_tp_report 05:45:02 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 05:45:02 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 05:45:02 INFO - PROCESS | 1684 | |i|pagename|runs| 05:45:02 INFO - PROCESS | 1684 | |0;ai-astar;110;106;109;110;107;104;116;109;108;109 05:45:02 INFO - PROCESS | 1684 | |1;audio-beat-detection;157;122;155;186;119;151;170;100;187;151 05:45:02 INFO - PROCESS | 1684 | |2;audio-dft;184;200;265;193;183;188;180;181;182;180 05:45:02 INFO - PROCESS | 1684 | |3;audio-fft;77;74;87;78;56;58;57;78;78;56 05:45:02 INFO - PROCESS | 1684 | |4;audio-oscillator;91;96;125;78;80;81;109;106;117;149 05:45:02 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;87;90;85;87;130;140;84;91;84;90 05:45:02 INFO - PROCESS | 1684 | |6;imaging-darkroom;123;149;144;93;93;93;93;93;110;150 05:45:02 INFO - PROCESS | 1684 | |7;imaging-desaturate;86;87;88;84;87;85;84;85;85;86 05:45:02 INFO - PROCESS | 1684 | |8;json-parse-financial;56;57;55;54;53;54;55;61;52;52 05:45:02 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;64;63;78;73;70;66;66;67;68;68 05:45:02 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;83;81;83;83;84;83;83;85;86;84 05:45:02 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;126;126;122;120;120;120;121;118;122;120 05:45:02 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;138;124;138;140;140;127;166;176;134;137 05:45:02 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;65;69;66;67;67;67;68;69;67;67 05:45:02 INFO - PROCESS | 1684 | __end_tp_report 05:45:02 INFO - PROCESS | 1684 | __start_cc_report 05:45:02 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1115 05:45:02 INFO - PROCESS | 1684 | __end_cc_report 05:45:02 INFO - PROCESS | 1684 | __startTimestamp1455543902721__endTimestamp 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | ------- Summary: start ------- 05:45:02 INFO - PROCESS | 1684 | Number of tests: 14 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:3.16 (2.9%) stddev-sans-first:3.32 05:45:02 INFO - PROCESS | 1684 | Values: 110.0 106.0 109.0 110.0 107.0 104.0 116.0 109.0 108.0 109.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:156.00 stddev:28.65 (18.4%) stddev-sans-first:30.27 05:45:02 INFO - PROCESS | 1684 | Values: 157.0 122.0 155.0 186.0 119.0 151.0 170.0 100.0 187.0 151.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:193.60 Median:186.00 stddev:25.90 (13.9%) stddev-sans-first:27.24 05:45:02 INFO - PROCESS | 1684 | Values: 184.0 200.0 265.0 193.0 183.0 188.0 180.0 181.0 182.0 180.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:69.90 Median:77.50 stddev:11.79 (15.2%) stddev-sans-first:12.22 05:45:02 INFO - PROCESS | 1684 | Values: 77.0 74.0 87.0 78.0 56.0 58.0 57.0 78.0 78.0 56.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:79.00 stddev:22.78 (28.8%) stddev-sans-first:23.73 05:45:02 INFO - PROCESS | 1684 | Values: 91.0 96.0 125.0 78.0 80.0 81.0 109.0 106.0 117.0 149.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:96.80 Median:87.00 stddev:20.42 (23.5%) stddev-sans-first:21.35 05:45:02 INFO - PROCESS | 1684 | Values: 87.0 90.0 85.0 87.0 130.0 140.0 84.0 91.0 84.0 90.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:114.10 Median:93.00 stddev:25.22 (27.1%) stddev-sans-first:26.54 05:45:02 INFO - PROCESS | 1684 | Values: 123.0 149.0 144.0 93.0 93.0 93.0 93.0 93.0 110.0 150.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.34 (1.6%) stddev-sans-first:1.41 05:45:02 INFO - PROCESS | 1684 | Values: 86.0 87.0 88.0 84.0 87.0 85.0 84.0 85.0 85.0 86.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:2.69 (4.9%) stddev-sans-first:2.82 05:45:02 INFO - PROCESS | 1684 | Values: 56.0 57.0 55.0 54.0 53.0 54.0 55.0 61.0 52.0 52.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:4.45 (6.5%) stddev-sans-first:4.44 05:45:02 INFO - PROCESS | 1684 | Values: 64.0 63.0 78.0 73.0 70.0 66.0 66.0 67.0 68.0 68.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:1.35 (1.6%) stddev-sans-first:1.42 05:45:02 INFO - PROCESS | 1684 | Values: 83.0 81.0 83.0 83.0 84.0 83.0 83.0 85.0 86.0 84.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:121.50 stddev:2.64 (2.2%) stddev-sans-first:2.24 05:45:02 INFO - PROCESS | 1684 | Values: 126.0 126.0 122.0 120.0 120.0 120.0 121.0 118.0 122.0 120.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:139.00 stddev:16.36 (11.8%) stddev-sans-first:17.29 05:45:02 INFO - PROCESS | 1684 | Values: 138.0 124.0 138.0 140.0 140.0 127.0 166.0 176.0 134.0 137.0 05:45:02 INFO - PROCESS | 1684 | 05:45:02 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.01 05:45:02 INFO - PROCESS | 1684 | Values: 65.0 69.0 66.0 67.0 67.0 67.0 68.0 69.0 67.0 67.0 05:45:02 INFO - PROCESS | 1684 | -------- Summary: end -------- 05:45:02 INFO - PROCESS | 1684 | 05:45:03 INFO - TEST-INFO | 1684: exit 0 05:45:03 INFO - TEST-OK | kraken | took 57100ms 05:45:03 INFO - SUITE-END | took 1171s 05:45:03 INFO - Completed test suite (00:19:31) 05:45:03 INFO - Working with test: dromaeo_css 05:45:03 INFO - Generating results file: dromaeo_css 05:45:03 INFO - Working with test: kraken 05:45:03 INFO - Generating results file: kraken 05:45:03 INFO - javascript benchmark 05:45:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:45:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 05:45:06 INFO - process_Request line: dromaeo_css 7377.01 graph.html#tests=[[72,64,59]] 05:45:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:45:06 INFO - process_Request line: kraken 1459.30 graph.html#tests=[[232,64,59]] 05:45:06 INFO - RETURN: dromaeo_css: 7377.01 05:45:06 INFO - RETURN: kraken: 1459.30 05:45:06 INFO - javascript benchmark 05:45:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3363.613184483784, 3420.8631654733813, 3446.879359222428, 3458.4120699481095, 3500.702440292575, 5476.17857321402, 5518.558515318775, 5578.163275508676, 5586.553075753935, 5593.468620481053, 5565.332160140779, 5594.104943209088, 5619.438056194378, 5673.432656734335, 5684.033714268574, 5041.294218809369, 5043.445221025684, 5066.3920329560415, 5086.237064440326, 5151.072806894757, 5126.512981266774, 5131.563817075553, 5191.402988656297, 5193.740312984354, 5244.292020577231, 5072.061668591304, 5082.1360368737405, 5147.742612869341, 5152.92270615941, 5157.3811142662935, 5132.923006154911, 5137.922931156036, 5156.20078887773, 5177.042247184283, 5186.844394668166, 5073.847784566469, 5087.491250874883, 5127.435982041972, 5128.461511541309, 5137.717425541594, 4541.886452838672, 5436.510714035716, 5474.37044739856, 5526.58550608706, 5546.0, 6137.346341658241, 6147.969260153715, 6149.877002459926, 6153.569250152491, 6154.199954005995, 6150.692465376758, 6188.783392581238, 6197.349278325801, 6216.844578885519, 6220.409061139185, 5573.359063707644, 5667.574931880125, 5683.914741278884, 5687.260656114679, 5809.651420914759, 6277.183966084471, 6278.654673992883, 6304.243490781044, 6309.242890853127, 6313.905291420632, 5928.229330187134, 5934.940650593525, 5978.372270911578, 5993.760249589967, 5998.550108741774, 6052.334243233241, 6143.477804386588, 6144.07838824171, 6182.629042257479, 6220.409061139185, 6060.000099983454, 6103.6104255942055, 6109.01176576301, 6116.061877111514, 6129.481048574139, 5954.642721436728, 6107.83571684662, 6118.649636126596, 6140.289530736369, 6151.446369826737, 4804.327394164819, 4813.4945830687975, 4820.156472617278, 4821.566059054702, 4874.926876096862, 4323.4379530661445, 4334.50153232376, 4341.761203133795, 4375.971646663032, 4393.626541743924, 5487.122060470386, 5554.416786237387, 5564.276644036249, 5564.916526252109, 5565.9721701392045, 6041.214642096499, 6110.406879924458, 6124.136831511461, 6131.478824299896, 6196.132541444202, 5541.085720856014, 5552.3892371839065, 5565.332160140728, 5566.2207290979295, 5574.442555744474, 5198.740062996835, 5262.394824595144, 5273.103572392626, 5281.181416880389, 5283.260343551906, 6230.937690623035, 6261.467775239155, 6301.905471417932, 6305.684715764193, 6308.936910630835, 6167.321594624498, 6175.042868355412, 6205.751769929333, 6213.875722485615, 6232.314445411092, 6273.65494897785, 6280.748770049329, 6300.369963003663, 6306.0, 6308.400701933309, 5919.437653422918, 6011.0, 6025.698715064317, 6028.698565071817, 6035.547333949883, 6101.054336577838, 6114.785982490592, 6122.78570250057, 6125.326214116354, 6128.785492507741, 5882.058870580687, 5909.113632955091, 5915.260592425947, 5918.082697181943, 5936.5844390892225, 5729.312482502127, 5890.7349169288345, 5912.556558258062, 5957.165996760544, 6007.759689612367, 5695.914561281501, 5808.651480911159, 5823.70881455934, 5844.532437405082, 5853.882922341444, 5933.080372542263, 5970.253718285215, 5979.760809567742, 6048.425399587032, 6051.1830902829315, 5773.162891380643, 5815.156802263733, 5819.738111785065, 5837.67892765902, 5876.559258055749], "unit": "score", "name": "dojo.html", "value": 5603.431870054917}, {"lowerIsBetter": false, "replicates": [439.20723094813866, 449.4920739564292, 463.11776066593154, 534.9331333583302, 561.0462214235799, 39137.80431097844, 39858.800705996466, 39864.80067599665, 39902.60097399025, 39953.0011749706, 31491.68508314916, 31811.840940795322, 31855.36289274213, 42964.0, 43676.344854827126, 9389.436633801959, 9590.520473976308, 9616.08647178517, 9617.0, 9627.181689556395, 8066.314363279128, 9444.952775236114, 9671.70984870455, 9674.613015479372, 9677.37097088687, 8708.825823483527, 8908.8663670045, 9613.038696130401, 9699.612015519371, 11488.425578721073, 11436.428178591037, 11565.537378504807, 11572.768544629145, 11578.710532236677, 11619.012383947374, 11317.943410282896, 11467.885321146765, 11480.71298217543, 11489.885101148966, 11495.885041149566, 38277.0, 38577.03557411087, 38581.0, 38603.61396386028, 38616.0, 3148.984255078733, 3406.403879321109, 3704.462852886343, 3748.137928276484, 3972.245273398045, 27904.720952790416, 28791.56812647812, 29355.0, 29412.558811617844, 29577.40845183106, 2696.9730302696917, 2769.806113572051, 2793.7485626293733, 2853.6432945881766, 2859.571064340345, 359270.0, 362771.18614407023, 365549.34450655687, 365852.0, 366107.0, 65392.673036634515, 65626.0, 65642.0, 65735.0, 65742.67128664326, 69748.0, 70048.0, 70075.64962175259, 70085.29914700787, 70347.0, 16304.592385190464, 16824.242909069122, 16830.663386732198, 16842.663146736995, 16845.494635160965, 12800.93599532015, 12829.679258018625, 12856.035797315239, 12865.48538058486, 12897.48410063587, 16743.832561674226, 16908.57728556796, 20340.389788306078, 20879.582408351747, 21126.683099753514, 7837.843243135219, 7918.326942209977, 8645.567721613894, 8725.21473067427, 8966.103389661112, 886.4282537763106, 955.7658373698488, 986.8569057486624, 1090.4711215060688, 1109.1847492093304, 28885.56671649927, 29226.561601575995, 29519.55720664192, 29770.10689679313, 29875.0, 898.2409863665192, 1010.8989101089833, 1081.8377243413552, 1088.7985722641338, 1189.3171162804708, 14774.556763297118, 14832.925835370754, 14835.554933352018, 15184.848151518343, 15201.695966080617, 520465.0, 528578.0, 529015.0, 529428.0, 530159.0, 56927.14609280864, 57618.135727964116, 57688.42311576915, 57751.711241443525, 57752.133717994264, 1399.8110255115632, 1413.5759272218293, 1429.6711756296318, 1434.3258668425824, 1439.6904665496968, 29225.97709080257, 29868.253293667833, 31086.22284442907, 31088.378232435676, 31745.20636984094, 51689.48310516847, 52461.21308180304, 52464.0, 52569.47430525646, 52638.47361526489, 457497.0, 467541.66229168634, 477458.86681897903, 488447.0, 512049.0, 34060.659393405746, 40601.0, 41426.0, 41564.960875978344, 41964.790176048926, 43318.8523893554, 43383.13233735371, 43811.561884380746, 44709.55290447054, 44810.77594612006, 28785.30484109727, 30911.845440772653, 34942.82528587442, 35134.94595162149, 37066.25867482581, 29743.553846691884, 34819.82590087033, 36018.4597231047, 36100.63899361078, 36459.635403645625, 34992.9502114937, 36093.819530902176, 36145.0, 36160.81919590385, 36203.63796362003, 30806.691933080383, 31598.36803263876, 31629.525557117122, 31695.366092677556, 31758.36483270368, 17704.55738606545, 20977.685334720296, 23683.52632947297, 25286.49427011486, 25353.295508510437], "unit": "score", "name": "ext.html", "value": 19738.07043966691}, {"lowerIsBetter": false, "replicates": [315.7631776167874, 367.0969415238513, 372.89745320036997, 373.23673088533945, 374.8762908240281, 16125.596860078489, 18397.17212725427, 18964.05179741011, 18968.62062758744, 19465.124069416874, 14700.632484187874, 18787.3424430145, 19083.713744293847, 19122.904385478087, 19526.51183720404, 5531.723413829312, 5731.054376027951, 5904.439078287556, 5919.496842768348, 5930.288365396137, 5497.47773961473, 5592.552595792326, 5641.266635337421, 5641.605087643867, 5762.279715035621, 3844.692424606039, 4015.6185162409524, 5633.15502674598, 5755.798547050854, 5770.307563092435, 5768.134779783024, 5835.241418615574, 5838.824835254928, 5842.678652674102, 6040.728167232485, 5485.341758988907, 5633.943660563383, 5642.605017648766, 5647.152927060933, 5651.982643124236, 17504.474865754048, 20543.945605439338, 22436.43908902274, 23055.193068242697, 23100.19149329782, 2108.125128071864, 2166.967495487569, 2395.38917576017, 2457.8648174350405, 2595.8312709674, 9488.810223795554, 9656.179224765903, 9689.660861869801, 9956.601735930553, 13689.0, 1708.7949446066427, 1779.0482092080804, 1787.4190887961336, 1788.534980904974, 1822.0161112999097, 76376.61811690961, 93294.53352733194, 93485.0, 93537.0646293542, 94099.52950235273, 10895.83656245157, 10981.286216396069, 11001.504932278067, 11027.779444411068, 11107.722306942229, 13157.407916643773, 13290.468381264642, 13309.733805324033, 13325.533606323732, 13330.800037999437, 7073.858522829618, 8127.699568069199, 8332.083470818205, 8343.165683431609, 8439.451435656663, 8467.068622451525, 8486.278666313432, 8489.787755306043, 8578.914210857936, 8588.355873309401, 4261.70168088237, 4324.437823082979, 4341.717788343748, 4376.562343765598, 4384.978075109668, 1808.4303444414968, 1841.7513635659016, 1850.9722354164699, 1855.2022630269114, 1857.6934805756898, 365.8682874165298, 368.8690514867237, 391.9333713268751, 749.539033494397, 920.6225447566466, 9882.901170988342, 11082.279651822606, 11357.318560886373, 11741.29552226869, 11876.465559049864, 442.26363105429743, 451.17885448483446, 458.99082018360116, 465.56702266892114, 487.4004973882074, 4432.822687092545, 5666.603337766317, 5754.05058165398, 6050.6672133032225, 6229.56393052482, 507744.0, 512508.0, 550082.0, 560337.0, 560723.0, 113601.43199283951, 116867.41566292114, 117677.0, 119056.0, 121711.39144304399, 1029.8414283930579, 1114.5653195253858, 1159.2291126401017, 1161.8199179127248, 1173.1318824070127, 14962.251887405368, 17528.474145775646, 17714.5571360717, 18055.458336249932, 18117.637647246716, 49867.0, 50998.23502647389, 51219.975600487036, 51578.968420632125, 51709.7414512925, 69703.65148174227, 75026.0, 75674.24325756672, 75754.0, 75989.50917946796, 7380.630968451448, 7497.850042999, 7501.924980750123, 7516.962415187889, 7584.127825300161, 8402.0, 10128.797424051625, 11803.23278986863, 12131.878681213075, 12453.920890688632, 9762.511874406393, 10000.399976001172, 10276.537555809857, 10407.375557466576, 10424.530896109542, 10001.54993025301, 10162.89837101649, 10397.792044158923, 10455.268131230741, 10457.97159133336, 10405.375677459377, 10492.947535262274, 10571.5242814072, 10661.200409969439, 10686.305390149615, 7378.852422951618, 7399.556026638419, 7475.738349157753, 7491.438142139253, 7548.245175482408, 8131.878021829795, 10314.535845887103, 10349.534270957674, 10477.790444191225, 10500.212484063879], "unit": "score", "name": "jquery.html", "value": 8445.604430844667}, {"lowerIsBetter": false, "replicates": [1401.1032938919086, 1522.1171720402167, 1550.5193390049083, 1778.164262796486, 1933.719610656455, 7818.17909119542, 8391.748247552576, 8468.280196183332, 8470.534120623362, 8472.83054338913, 8229.0, 8340.499570025788, 8419.789505262355, 8424.283935865458, 8458.661653533867, 2157.7302837145357, 2208.0615738311235, 2452.227548322277, 2475.9133430329853, 2476.938076548083, 2009.2164056018164, 2226.476777957179, 2234.54191890662, 2237.127520267097, 2477.55404027275, 2444.8166387521005, 2447.2046584859904, 2448.069733501267, 2448.412381028549, 2449.1428000199876, 2387.9999999999914, 2442.6091825308044, 2444.8166387521005, 2447.7919376852988, 2451.460678650694, 2398.604230301998, 2443.9511209775883, 2444.914427995029, 2445.08309383981, 2451.6445115458337, 7433.739819106359, 8112.31045361145, 8531.445456045338, 8705.738827835175, 8746.912530874673, 5285.947140528584, 5446.183072539111, 5449.945500544984, 5454.809081682122, 5459.071957767189, 3040.19434849765, 3597.9820100899587, 3607.6753092221566, 3607.693346065588, 3716.2195938852874, 1031.8968103189695, 1036.0, 1077.6389909380289, 1079.1618044542881, 1079.611339917629, 11746.882531174664, 11763.941180294129, 11765.05879529627, 11773.058155347551, 11786.646400607995, 4800.687955282895, 4839.564439200489, 4923.113839508851, 4941.160002799533, 4953.851384458472, 10067.395956242648, 10110.646127385506, 10110.747231319276, 10115.0, 10136.847947280796, 5430.538404235605, 5459.099248623933, 5465.988792073479, 5471.398146203915, 5471.562275017989, 4364.039911219526, 4787.018661174451, 4924.8276310328965, 4970.90058198834, 4982.676126051868, 3704.1850792825535, 3715.3126671565306, 3761.360568703327, 3762.774233545941, 3811.1996480739354, 1131.598282609678, 1138.317009794117, 1184.9111316651286, 1198.5804968261039, 1199.1366216324232, 1308.1039487950784, 1308.6989992301824, 1318.1036894911551, 1344.0927374022497, 1348.2854087333728, 8017.037955445384, 8084.676612935535, 8130.878036829452, 8136.34909207262, 8138.064122625856, 1104.8177050786692, 1139.367650953712, 1194.134252666827, 1204.566356111799, 1216.969575760613, 6280.120783090371, 6314.71583778731, 6382.393672601095, 6392.520560957947, 6397.136386587844, 10256.12822910061, 10491.842622360671, 10613.0, 10622.840657390145, 10639.840402393971, 9830.557624906896, 10449.84325235122, 10474.214433917334, 10475.214358923111, 10482.63310784119, 8109.270165685117, 8244.010718713793, 8313.418060735812, 8317.8336433271, 8319.251267385844, 8003.999500062492, 8005.479643823133, 8107.878381824396, 8110.878336824834, 8139.633716482891, 9512.762180945532, 9565.521723913917, 9584.520773961414, 9637.518124093907, 9759.804803904024, 9835.60657573689, 9895.25785566071, 9979.45113018791, 10110.241731869992, 10134.543945522617, 7450.0687414073245, 7463.962680186564, 7536.397088233038, 7560.941468194567, 7572.621368931421, 7247.601381924045, 8088.191180881865, 8145.470544414594, 8146.266835984789, 8178.223068808454, 6763.12079429671, 7275.599842008529, 7720.922790772021, 7780.144184139854, 7950.920490795018, 7617.047869016373, 7635.083789945242, 7682.7311044113185, 7727.652255648622, 7751.37988960893, 7775.300222979959, 7834.764957051298, 7837.6081195941115, 7855.84288314242, 7862.72480463181, 6980.581165130108, 7011.26381729911, 7067.57594544329, 7098.148222213367, 7098.964505177441, 6015.248093988252, 7136.393406560501, 7172.533785303938, 7176.318249766264, 7180.425565954815], "unit": "score", "name": "mootools.html", "value": 4904.079093169272}, {"lowerIsBetter": false, "replicates": [315.6448994880759, 321.18259030766694, 327.3044779842834, 328.81257683120623, 332.1381016262797, 6578.914479110941, 6580.407763301302, 6583.4074933256, 6595.0437186607915, 6666.4000239978395, 6540.444062254702, 6543.083968244449, 6545.476361891049, 6561.77033803817, 6583.868322633544, 4773.832915847946, 4889.242167464049, 4889.339939108219, 4902.583280421169, 4921.360223170983, 4876.902461950759, 4887.511248875119, 4915.606751459874, 4915.992221594564, 4921.901561968776, 4823.686460380081, 4836.226203807391, 4836.250381190921, 4845.273209018657, 4857.53853383928, 4602.0, 4687.835925742616, 4728.83449079284, 4835.419749630049, 4855.854324370257, 4070.9185816283803, 4121.237571049365, 4124.484439445069, 4133.91732165355, 4140.772257525835, 6252.499800015988, 6299.307076221612, 6304.27500837405, 6314.621122732605, 6320.652364119972, 5394.32570928634, 5523.364813046511, 5526.751296191681, 5637.3517045539875, 5663.5186009189265, 6915.343042411013, 6922.480813938924, 6924.23833378328, 6941.687624056879, 6943.79168624942, 4634.930476042862, 4643.721376717408, 4646.186917289495, 4660.231061874787, 4662.230731929228, 5972.940270597282, 7107.786766397016, 7365.153007404164, 7384.15082265541, 7394.852102957964, 4737.38414006177, 4743.1225223333795, 4744.905101898012, 4746.857594272177, 4752.904941901143, 4819.746865814844, 4821.807127714852, 4836.081144582518, 4840.104580652591, 4844.539768721966, 5316.362036555561, 5681.517071049007, 5682.886342273131, 5686.317641882918, 5690.886182276331, 5605.467480589419, 6943.72225111, 6944.097267355211, 6956.617386043817, 7000.929990700028, 1329.5346628679886, 1401.4604377314806, 1594.330381239882, 1621.7161996650539, 1625.2848746551479, 1022.6778564752079, 1033.844923261517, 1037.1650821089095, 1038.4496217004998, 1054.4200689620677, 6427.742890284337, 6435.0, 6435.646039467781, 6452.903206451907, 6472.741090356333, 7157.498975071695, 7167.713291468387, 7170.641467926583, 7172.928270717331, 7193.0, 5680.943190568041, 5998.610090344114, 6369.108324834527, 6437.935620643827, 6438.45273151778, 3845.5193100862393, 3878.495795546561, 3878.7284890057426, 3890.183061557048, 3896.8246428910766, 7632.389408847279, 7638.770836874903, 7657.34912532441, 7662.0, 7686.538807671557, 7120.501564890408, 7314.403386797717, 7347.228541003117, 7400.703971841173, 7602.163761986177, 7118.9644051779405, 7588.924110758932, 7599.772006839804, 7682.6158692064055, 7706.460547761603, 7387.150477695134, 7388.408927285696, 7405.7778266652085, 7407.62961851916, 7428.554286742813, 6981.406580440719, 7251.057362542836, 7266.1280646322775, 7286.7085316586745, 7292.270772922665, 7652.464327497022, 7687.961560192163, 7691.961540192263, 7692.499987500794, 7705.653245604073, 3793.2982398256413, 4631.513691062525, 4642.141203877159, 4644.628429725682, 4646.697964632288, 7068.752593659197, 7315.817104572216, 7338.70645174187, 7350.669219885225, 7358.0434543509, 7100.076989991268, 7105.253948335557, 7112.431005519649, 7117.153138744544, 7117.75087871922, 6836.5214434989075, 7086.0, 7091.290870913073, 7096.432285417258, 7096.964515177391, 6937.7224911002995, 6938.653067346713, 6942.51402401827, 6950.443964482728, 6956.860862782817, 7082.362587367162, 7090.893636595559, 7096.858062838817, 7109.857802844018, 7121.216666166821, 6770.0, 6952.0, 6964.338387853146, 6968.895466568107, 6987.441004719712], "unit": "score", "name": "prototype.html", "value": 5130.70970082851}, {"lowerIsBetter": false, "replicates": [680.8740383029143, 685.4242436353463, 701.884189108797, 713.2012146396037, 736.329939754823, 14523.709525809478, 14835.703285934289, 17101.31594736209, 17410.95534267945, 17418.738718919227, 15763.21183940804, 15851.841481585181, 15855.445059422922, 15863.682726345467, 15864.682706345866, 717.125107369009, 726.4696771356913, 859.9613017414216, 871.4988881393192, 884.3588398411165, 870.1211776106115, 873.5457562067721, 881.7531091294447, 881.8985816631106, 883.4434306386967, 918.17364372065, 920.5949382271813, 921.4517362169498, 922.7324076017946, 924.3575714878162, 737.4284929179875, 749.3929916767381, 903.3586153830788, 914.0950459045497, 917.5045475443253, 683.9658017099175, 684.5105749389161, 684.7295318349225, 685.766839274649, 689.1454596300601, 14909.403623855032, 14917.925410372987, 14960.0, 14988.850111498854, 15101.32044058009, 12135.817962730565, 12207.511699532008, 12267.202631828992, 12549.560765373168, 12758.936205319007, 8257.504549726975, 10158.746031349201, 10196.949015254877, 10245.129164021067, 10897.67306980792, 3485.4597537381746, 3495.8601655933985, 3544.787312761217, 3561.2343346180437, 3609.855605775766, 75015.87476187861, 75595.62202189009, 76629.85055224175, 84202.73695894566, 84913.0, 9349.15857572808, 9391.718248452557, 9443.961164271925, 9485.0, 9614.942356340796, 19843.40469785909, 19847.503812404517, 19876.801231987494, 19883.30408435698, 19919.302824401075, 7276.417886569062, 7404.370628496638, 7414.814629634195, 7522.172561018284, 7641.044869391326, 4134.255833949857, 4172.77049762266, 4188.790560471964, 4192.790360481964, 4239.1521695660995, 3504.3166582516164, 3550.840212190458, 3557.7153827693724, 3563.94654080189, 3566.0728210665416, 566.0462121325497, 572.4418691775486, 581.880714453536, 668.4919461209419, 699.646678427391, 560.025555533369, 572.2960758267354, 602.7197353230681, 619.5508256514081, 635.9046143078575, 8322.62548185333, 8371.576831938584, 8449.089649466468, 8739.21347078766, 8809.33929955256, 524.307913554105, 551.4705882352906, 596.7463827873223, 604.5767962426319, 615.9876802464015, 3864.729468937204, 4009.4386785850006, 4081.0, 4122.216778812076, 4123.257813593582, 93051.53474232585, 93658.0, 95164.52417738005, 95172.52413737887, 95459.0, 65104.023439648445, 85027.87430314168, 85375.0, 85442.0, 86163.56918215494, 59558.70220648869, 60857.0, 61025.084623730676, 61237.0, 62401.68799156066, 8050.355971522147, 8110.675572977015, 8183.0, 8325.626271665107, 8329.708460203863, 49510.75244623754, 49624.0, 50228.748856255486, 50445.0, 50470.74764626153, 68950.965735513, 70953.64523177351, 71548.3493572916, 72862.0, 77359.61320193364, 9766.316357854881, 9833.85249221248, 9959.950200249243, 10009.449480278654, 10460.68617941463, 11907.191472077031, 12013.45939432745, 12441.93779031099, 12586.87413125857, 12806.679833003876, 11219.831702524305, 11221.55113795439, 11264.549418023515, 11422.714432139262, 12028.458719357475, 11141.997220250216, 11527.0, 11650.88349116498, 12171.756903436279, 12183.380573176455, 10291.279610427198, 11021.118310534977, 11035.062019728091, 11263.774724505627, 11847.703807404883, 8879.733607991771, 8918.0, 9061.592228349607, 9082.682106126254, 9761.170300524534, 9075.410098343587, 9495.14543691071, 10006.899931000597, 10036.498175091363, 10039.34744241622], "unit": "score", "name": "yui.html", "value": 6856.848403605169}], "name": "dromaeo_css", "value": 7377.012790020215}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 109.0, 110.0, 107.0, 104.0, 116.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [157.0, 122.0, 155.0, 186.0, 119.0, 151.0, 170.0, 100.0, 187.0, 151.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [184.0, 200.0, 265.0, 193.0, 183.0, 188.0, 180.0, 181.0, 182.0, 180.0], "unit": "score", "name": "audio-dft", "value": 193.6}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 87.0, 78.0, 56.0, 58.0, 57.0, 78.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [91.0, 96.0, 125.0, 78.0, 80.0, 81.0, 109.0, 106.0, 117.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [87.0, 90.0, 85.0, 87.0, 130.0, 140.0, 84.0, 91.0, 84.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.8}, {"lowerIsBetter": true, "replicates": [123.0, 149.0, 144.0, 93.0, 93.0, 93.0, 93.0, 93.0, 110.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 114.1}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 88.0, 84.0, 87.0, 85.0, 84.0, 85.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 54.0, 53.0, 54.0, 55.0, 61.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 78.0, 73.0, 70.0, 66.0, 66.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 83.0, 83.0, 84.0, 83.0, 83.0, 85.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [126.0, 126.0, 122.0, 120.0, 120.0, 120.0, 121.0, 118.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [138.0, 124.0, 138.0, 140.0, 140.0, 127.0, 166.0, 176.0, 134.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 66.0, 67.0, 67.0, 67.0, 68.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1459.3000000000002}]} 05:45:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1459.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7377.01"}}} 05:45:06 INFO - Return code: 0 05:45:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:45:06 INFO - # TBPL SUCCESS # 05:45:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:45:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:45:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:45:06 INFO - 2016-02-15 05:45:06.915 screenresolution[1688:9689] starting screenresolution argv=screenresolution get 05:45:06 INFO - 2016-02-15 05:45:06.918 screenresolution[1688:9689] Display 0: 1600x1200x32@60 05:45:06 INFO - 2016-02-15 05:45:06.924 screenresolution[1689:9692] starting screenresolution argv=screenresolution list 05:45:06 INFO - Available Modes on Display 0 05:45:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:45:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:45:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:45:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:45:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:45:07 INFO - Intel Iris: 05:45:07 INFO - Chipset Model: Intel Iris 05:45:07 INFO - Type: GPU 05:45:07 INFO - Bus: Built-In 05:45:07 INFO - VRAM (Dynamic, Max): 1536 MB 05:45:07 INFO - Vendor: Intel (0x8086) 05:45:07 INFO - Device ID: 0x0a2e 05:45:07 INFO - Revision ID: 0x0009 05:45:07 INFO - Displays: 05:45:07 INFO - Display: 05:45:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:45:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:45:07 INFO - Display Serial Number: 1600x1200 60 05:45:07 INFO - Main Display: Yes 05:45:07 INFO - Mirror: Off 05:45:07 INFO - Online: Yes 05:45:07 INFO - Rotation: Supported 05:45:07 INFO - Return code: 0 05:45:07 INFO - Running post-action listener: _resource_record_post_action 05:45:07 INFO - Running post-run listener: _resource_record_post_run 05:45:08 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 38811136; Write bytes: 708797440; Read time: 420; Write time: 2062 05:45:08 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404619776; Write bytes: 394462720; Read time: 30366; Write time: 702 05:45:08 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31702528; Write bytes: 300682752; Read time: 333; Write time: 1323 05:45:08 INFO - Running post-run listener: _upload_blobber_files 05:45:08 INFO - Blob upload gear active. 05:45:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45:08 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 05:45:08 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'] 05:45:08 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 05:45:08 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:09 INFO - (blobuploader) - INFO - Done attempting. 05:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:10 INFO - (blobuploader) - INFO - Done attempting. 05:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:10 INFO - Return code: 0 05:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9831e7672ca51eba24abe69895e3fcd218ad0e1969673a78b1572c139573d52867c24e053202a3b770a6f776deaf9218691e47a05fad0ef155c481397e9fcb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39feb14622dfcaa5f03e7228e92c4123d4cf22b430973df945de8cb2b48f61b798e0e385713e51f982c7380bd5def91fad3bee330107dd471022f7347ff147d0"} 05:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:45:10 INFO - Contents: 05:45:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9831e7672ca51eba24abe69895e3fcd218ad0e1969673a78b1572c139573d52867c24e053202a3b770a6f776deaf9218691e47a05fad0ef155c481397e9fcb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39feb14622dfcaa5f03e7228e92c4123d4cf22b430973df945de8cb2b48f61b798e0e385713e51f982c7380bd5def91fad3bee330107dd471022f7347ff147d0"} 05:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 05:45:10 INFO - Copying logs to upload dir... 05:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 05:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.296923 ========= master_lag: -0.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-15 05:45:09.752246) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 05:45:09.755683) ========= 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.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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/9831e7672ca51eba24abe69895e3fcd218ad0e1969673a78b1572c139573d52867c24e053202a3b770a6f776deaf9218691e47a05fad0ef155c481397e9fcb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39feb14622dfcaa5f03e7228e92c4123d4cf22b430973df945de8cb2b48f61b798e0e385713e51f982c7380bd5def91fad3bee330107dd471022f7347ff147d0"} build_url:https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011096 build_url: 'https://queue.taskcluster.net/v1/task/NtJojU0cR2SUt5msVRBylg/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/9831e7672ca51eba24abe69895e3fcd218ad0e1969673a78b1572c139573d52867c24e053202a3b770a6f776deaf9218691e47a05fad0ef155c481397e9fcb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39feb14622dfcaa5f03e7228e92c4123d4cf22b430973df945de8cb2b48f61b798e0e385713e51f982c7380bd5def91fad3bee330107dd471022f7347ff147d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 05:45:09.782696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 05:45:09.783042) ========= 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.QogwgOAOaK/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.6gz1rxwSyu/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.004919 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 05:45:09.832637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 05:45:09.832994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 05:45:09.833483) ========= ========= Total master_lag: -0.33 =========