builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0024 starttime: 1455568424.46 results: success (0) buildid: 20160215113721 builduid: 166685368dba4293b126a4ea90bf89ad revision: 51577bed9ade8703bd80b7a0efa90d3c24d5bd52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.459011) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.459498) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.459799) ========= 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.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005026 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.482449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.482766) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.499588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.499884) ========= 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.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005655 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.548781) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.549084) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.549449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.549730) ========= 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.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 12:33:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-02-15 12:33:44 (15.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182307 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.750034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.750370) ========= 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.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.026954 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:44.799624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 12:33:44.799993) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 51577bed9ade8703bd80b7a0efa90d3c24d5bd52 --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 51577bed9ade8703bd80b7a0efa90d3c24d5bd52 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 12:33:44,819 truncating revision to first 12 chars 2016-02-15 12:33:44,819 Setting DEBUG logging. 2016-02-15 12:33:44,819 attempt 1/10 2016-02-15 12:33:44,819 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/51577bed9ade?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 12:33:45,942 unpacking tar archive at: fx-team-51577bed9ade/testing/mozharness/ program finished with exit code 0 elapsedTime=1.541271 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 12:33:46.357964) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:46.358415) ========= echo 51577bed9ade8703bd80b7a0efa90d3c24d5bd52 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'51577bed9ade8703bd80b7a0efa90d3c24d5bd52'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 51577bed9ade8703bd80b7a0efa90d3c24d5bd52 program finished with exit code 0 elapsedTime=0.005622 script_repo_revision: '51577bed9ade8703bd80b7a0efa90d3c24d5bd52' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:46.409240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:46.409611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 12:33:46.423037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-15 12:33:46.423398) ========= /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.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:33:46 INFO - MultiFileLogger online at 20160215 12:33:46 in /builds/slave/test 12:33:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:33:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:33:46 INFO - {'append_to_log': False, 12:33:46 INFO - 'base_work_dir': '/builds/slave/test', 12:33:46 INFO - 'blob_upload_branch': 'Fx-Team', 12:33:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:33:46 INFO - 'branch': 'Fx-Team', 12:33:46 INFO - 'buildbot_json_path': 'buildprops.json', 12:33:46 INFO - 'config_files': ('talos/mac_config.py',), 12:33:46 INFO - 'default_actions': ('clobber', 12:33:46 INFO - 'read-buildbot-config', 12:33:46 INFO - 'download-and-extract', 12:33:46 INFO - 'populate-webroot', 12:33:46 INFO - 'create-virtualenv', 12:33:46 INFO - 'install', 12:33:46 INFO - 'run-tests'), 12:33:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:33:46 INFO - 'download_minidump_stackwalk': True, 12:33:46 INFO - 'download_symbols': 'ondemand', 12:33:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:33:46 INFO - 'tooltool.py': '/tools/tooltool.py', 12:33:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:33:46 INFO - '/tools/misc-python/virtualenv.py')}, 12:33:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:33:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:33:46 INFO - 'installer_path': 'installer.exe', 12:33:46 INFO - 'log_level': 'info', 12:33:46 INFO - 'log_name': 'talos', 12:33:46 INFO - 'log_to_console': True, 12:33:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:33:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:33:46 INFO - 'opt_config_files': (), 12:33:46 INFO - 'pip_index': False, 12:33:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:33:46 INFO - 'cmd': ('bash', 12:33:46 INFO - '-c', 12:33:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:33:46 INFO - 'enabled': True, 12:33:46 INFO - 'halt_on_failure': False, 12:33:46 INFO - 'name': 'check_screen_resolution'},), 12:33:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:33:46 INFO - 'cmd': ('bash', 12:33:46 INFO - '-c', 12:33:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:33:46 INFO - 'enabled': True, 12:33:46 INFO - 'halt_on_failure': False, 12:33:46 INFO - 'name': 'check_screen_resolution'},), 12:33:46 INFO - 'run_cmd_checks_enabled': True, 12:33:46 INFO - 'sps_profile': False, 12:33:46 INFO - 'sps_profile_interval': 0, 12:33:46 INFO - 'suite': 'dromaeojs', 12:33:46 INFO - 'system_bits': '32', 12:33:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:33:46 INFO - 'title': 't-yosemite-r7-0024', 12:33:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:33:46 INFO - 'use_talos_json': True, 12:33:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:33:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:33:46 INFO - 'work_dir': 'build'} 12:33:46 INFO - ##### 12:33:46 INFO - ##### Running clobber step. 12:33:46 INFO - ##### 12:33:46 INFO - Running pre-action listener: _resource_record_pre_action 12:33:46 INFO - Running main action method: clobber 12:33:46 INFO - rmtree: /builds/slave/test/build 12:33:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:33:48 INFO - Running post-action listener: _resource_record_post_action 12:33:48 INFO - ##### 12:33:48 INFO - ##### Running read-buildbot-config step. 12:33:48 INFO - ##### 12:33:48 INFO - Running pre-action listener: _resource_record_pre_action 12:33:48 INFO - Running main action method: read_buildbot_config 12:33:48 INFO - Using buildbot properties: 12:33:48 INFO - { 12:33:48 INFO - "project": "", 12:33:48 INFO - "product": "firefox", 12:33:48 INFO - "script_repo_revision": "production", 12:33:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:33:48 INFO - "repository": "", 12:33:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:33:48 INFO - "buildid": "20160215113721", 12:33:48 INFO - "pgo_build": "False", 12:33:48 INFO - "basedir": "/builds/slave/test", 12:33:48 INFO - "buildnumber": 381, 12:33:48 INFO - "slavename": "t-yosemite-r7-0024", 12:33:48 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:33:48 INFO - "platform": "yosemite_r7", 12:33:48 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:33:48 INFO - "branch": "fx-team", 12:33:48 INFO - "repo_path": "integration/fx-team", 12:33:48 INFO - "revision": "51577bed9ade8703bd80b7a0efa90d3c24d5bd52", 12:33:48 INFO - "stage_platform": "macosx64", 12:33:48 INFO - "builduid": "166685368dba4293b126a4ea90bf89ad", 12:33:48 INFO - "slavebuilddir": "test" 12:33:48 INFO - } 12:33:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 12:33:48 INFO - Running post-action listener: _resource_record_post_action 12:33:48 INFO - ##### 12:33:48 INFO - ##### Running download-and-extract step. 12:33:48 INFO - ##### 12:33:48 INFO - Running pre-action listener: _resource_record_pre_action 12:33:48 INFO - Running main action method: download_and_extract 12:33:48 INFO - mkdir: /builds/slave/test/build/tests 12:33: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')]} 12:33:48 INFO - https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:33:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/test_packages.json 12:33:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/test_packages.json 12:33:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:33:49 INFO - Downloaded 1277 bytes. 12:33:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:33:49 INFO - Using the following test package requirements: 12:33:49 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:33:49 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:33:49 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 12:33:49 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:33:49 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 12:33:49 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:33:49 INFO - u'jsshell-mac.zip'], 12:33:49 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:33:49 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 12:33:49 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:33:49 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:33:49 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 12:33:49 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:33:49 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 12:33:49 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:33:49 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 12:33:49 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:33:49 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:33:49 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 12:33:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:49 INFO - https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:33:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:33:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:33:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/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 12:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/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 12:33:50 INFO - Downloaded 17758925 bytes. 12:33:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:33:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:33:53 INFO - Return code: 0 12:33:53 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 12:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:53 INFO - https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:33:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:33:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:33:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/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 12:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/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 12:33:54 INFO - Downloaded 17758925 bytes. 12:33:54 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'] 12:33:54 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 12:33:58 INFO - Return code: 0 12:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:58 INFO - https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:33:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:33:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:33:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/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 12:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/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 12:33:59 INFO - Downloaded 10707070 bytes. 12:33:59 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'] 12:33:59 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 12:33:59 INFO - Return code: 0 12:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:59 INFO - https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:33:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:33:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:33:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 12:33:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L79rns2cQOS4R__HFQhVAw/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 12:34:02 INFO - Downloaded 111151007 bytes. 12:34:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:34:02 INFO - mkdir: /builds/slave/test/properties 12:34:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:34:02 INFO - Writing to file /builds/slave/test/properties/build_url 12:34:02 INFO - Contents: 12:34:02 INFO - build_url:https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:34:03 INFO - Running post-action listener: _resource_record_post_action 12:34:03 INFO - Running post-action listener: set_extra_try_arguments 12:34:03 INFO - ##### 12:34:03 INFO - ##### Running populate-webroot step. 12:34:03 INFO - ##### 12:34:03 INFO - Running pre-action listener: _resource_record_pre_action 12:34:03 INFO - Running main action method: populate_webroot 12:34:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:34:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:34:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:34:03 INFO - '--tppagecycles', 12:34:03 INFO - '7'], 12:34:03 INFO - 'tests': ['tsvgm']}}, 12:34:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:34:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:34:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:34:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:34:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:03 INFO - 'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:03 INFO - 'tests': ['damp', 'tps']}, 12:34:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:03 INFO - 'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['damp', 'tps']}, 12:34:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:34:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:34:03 INFO - 'other': {'tests': ['a11yr', 12:34:03 INFO - 'ts_paint', 12:34:03 INFO - 'tpaint', 12:34:03 INFO - 'sessionrestore', 12:34:03 INFO - 'sessionrestore_no_auto_restore']}, 12:34:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['a11yr', 12:34:03 INFO - 'ts_paint', 12:34:03 INFO - 'tpaint', 12:34:03 INFO - 'sessionrestore', 12:34:03 INFO - 'sessionrestore_no_auto_restore']}, 12:34:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['a11yr', 12:34:03 INFO - 'ts_paint', 12:34:03 INFO - 'tpaint', 12:34:03 INFO - 'sessionrestore', 12:34:03 INFO - 'sessionrestore_no_auto_restore']}, 12:34:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['a11yr', 12:34:03 INFO - 'ts_paint', 12:34:03 INFO - 'tpaint', 12:34:03 INFO - 'sessionrestore', 12:34:03 INFO - 'sessionrestore_no_auto_restore']}, 12:34:03 INFO - 'other_l64': {'tests': ['a11yr', 12:34:03 INFO - 'ts_paint', 12:34:03 INFO - 'tpaint', 12:34:03 INFO - 'sessionrestore', 12:34:03 INFO - 'sessionrestore_no_auto_restore']}, 12:34:03 INFO - 'other_nol64': {'tests': ['a11yr', 12:34:03 INFO - 'ts_paint', 12:34:03 INFO - 'tpaint', 12:34:03 INFO - 'sessionrestore', 12:34:03 INFO - 'sessionrestore_no_auto_restore']}, 12:34:03 INFO - 'svgr': {'tests': ['tsvgx', 12:34:03 INFO - 'tsvgr_opacity', 12:34:03 INFO - 'tart', 12:34:03 INFO - 'tscrollx', 12:34:03 INFO - 'cart']}, 12:34:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['tsvgx', 12:34:03 INFO - 'tsvgr_opacity', 12:34:03 INFO - 'tart', 12:34:03 INFO - 'tscrollx', 12:34:03 INFO - 'cart']}, 12:34:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:03 INFO - 'tests': ['tp5o']}, 12:34:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:03 INFO - 'talos_options': ['--e10s'], 12:34:03 INFO - 'tests': ['tp5o']}, 12:34:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:03 INFO - 'talos_options': ['--xperf_path', 12:34:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:03 INFO - 'tests': ['tp5n']}, 12:34:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:03 INFO - 'talos_options': ['--e10s', 12:34:03 INFO - '--xperf_path', 12:34:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:03 INFO - 'tests': ['tp5n']}}, 12:34:03 INFO - 'talos.zip': {'path': '', 12:34:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:34:03 INFO - Running post-action listener: _resource_record_post_action 12:34:03 INFO - ##### 12:34:03 INFO - ##### Running create-virtualenv step. 12:34:03 INFO - ##### 12:34:03 INFO - Running pre-action listener: _resource_record_pre_action 12:34:03 INFO - Running main action method: create_virtualenv 12:34:03 INFO - Creating virtualenv /builds/slave/test/build/venv 12:34:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:34:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:34:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:34:03 INFO - Using real prefix '/tools/python27' 12:34:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:34:04 INFO - Installing distribute.............................................................................................................................................................................................done. 12:34:07 INFO - Installing pip.................done. 12:34:07 INFO - Return code: 0 12:34:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:07 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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:07 INFO - 'HOME': '/Users/cltbld', 12:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:07 INFO - 'LOGNAME': 'cltbld', 12:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:07 INFO - 'MOZ_NO_REMOTE': '1', 12:34:07 INFO - 'NO_EM_RESTART': '1', 12:34:07 INFO - 'PAGER': '/bin/cat', 12:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:07 INFO - 'PWD': '/builds/slave/test', 12:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:07 INFO - 'SHELL': '/bin/bash', 12:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:07 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:07 INFO - 'USER': 'cltbld', 12:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:07 INFO - 'XPC_FLAGS': '0x0', 12:34:07 INFO - 'XPC_SERVICE_NAME': '0', 12:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:34:07 INFO - Cleaning up... 12:34:07 INFO - Return code: 0 12:34:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:07 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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:07 INFO - 'HOME': '/Users/cltbld', 12:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:07 INFO - 'LOGNAME': 'cltbld', 12:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:07 INFO - 'MOZ_NO_REMOTE': '1', 12:34:07 INFO - 'NO_EM_RESTART': '1', 12:34:07 INFO - 'PAGER': '/bin/cat', 12:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:07 INFO - 'PWD': '/builds/slave/test', 12:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:07 INFO - 'SHELL': '/bin/bash', 12:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:07 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:07 INFO - 'USER': 'cltbld', 12:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:07 INFO - 'XPC_FLAGS': '0x0', 12:34:07 INFO - 'XPC_SERVICE_NAME': '0', 12:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:07 INFO - Downloading/unpacking psutil>=0.7.1 12:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:34:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:10 INFO - Installing collected packages: psutil 12:34:10 INFO - Running setup.py install for psutil 12:34:10 INFO - building 'psutil._psutil_osx' extension 12:34:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:34:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:34:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:34:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:34:11 INFO - building 'psutil._psutil_posix' extension 12:34:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:34:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:34:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:34:11 INFO - ^ 12:34:11 INFO - 1 warning generated. 12:34:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:11 INFO - Successfully installed psutil 12:34:11 INFO - Cleaning up... 12:34:11 INFO - Return code: 0 12:34:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:34:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:11 INFO - 'HOME': '/Users/cltbld', 12:34:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:11 INFO - 'LOGNAME': 'cltbld', 12:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:11 INFO - 'MOZ_NO_REMOTE': '1', 12:34:11 INFO - 'NO_EM_RESTART': '1', 12:34:11 INFO - 'PAGER': '/bin/cat', 12:34:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:11 INFO - 'PWD': '/builds/slave/test', 12:34:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:11 INFO - 'SHELL': '/bin/bash', 12:34:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:11 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:11 INFO - 'USER': 'cltbld', 12:34:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:11 INFO - 'XPC_FLAGS': '0x0', 12:34:11 INFO - 'XPC_SERVICE_NAME': '0', 12:34:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:34:14 INFO - Installing collected packages: mozsystemmonitor 12:34:14 INFO - Running setup.py install for mozsystemmonitor 12:34:14 INFO - Successfully installed mozsystemmonitor 12:34:14 INFO - Cleaning up... 12:34:14 INFO - Return code: 0 12:34:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:14 INFO - 'HOME': '/Users/cltbld', 12:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:14 INFO - 'LOGNAME': 'cltbld', 12:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:14 INFO - 'MOZ_NO_REMOTE': '1', 12:34:14 INFO - 'NO_EM_RESTART': '1', 12:34:14 INFO - 'PAGER': '/bin/cat', 12:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:14 INFO - 'PWD': '/builds/slave/test', 12:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:14 INFO - 'SHELL': '/bin/bash', 12:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:14 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:14 INFO - 'USER': 'cltbld', 12:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:14 INFO - 'XPC_FLAGS': '0x0', 12:34:14 INFO - 'XPC_SERVICE_NAME': '0', 12:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 12:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:17 INFO - Downloading blobuploader-1.2.4.tar.gz 12:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:34:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:18 INFO - Downloading docopt-0.6.1.tar.gz 12:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:34:18 INFO - Installing collected packages: blobuploader, requests, docopt 12:34:18 INFO - Running setup.py install for blobuploader 12:34:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:34:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:34:18 INFO - Running setup.py install for requests 12:34:18 INFO - Running setup.py install for docopt 12:34:19 INFO - Successfully installed blobuploader requests docopt 12:34:19 INFO - Cleaning up... 12:34:19 INFO - Return code: 0 12:34:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:19 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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:19 INFO - 'HOME': '/Users/cltbld', 12:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:19 INFO - 'LOGNAME': 'cltbld', 12:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:19 INFO - 'MOZ_NO_REMOTE': '1', 12:34:19 INFO - 'NO_EM_RESTART': '1', 12:34:19 INFO - 'PAGER': '/bin/cat', 12:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:19 INFO - 'PWD': '/builds/slave/test', 12:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:19 INFO - 'SHELL': '/bin/bash', 12:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:19 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:19 INFO - 'USER': 'cltbld', 12:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:19 INFO - 'XPC_FLAGS': '0x0', 12:34:19 INFO - 'XPC_SERVICE_NAME': '0', 12:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:19 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Zl7IkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:19 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-UrM6mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:19 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-bM7s4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:19 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-l4d16q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:19 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Gsdxmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:19 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-hve7bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-i_hp1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-cyw5kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-etn6Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ftlIzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-iYFiKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-3qi82B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-xWWGqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-pkJf7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:20 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-LneRoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:34:21 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-8MlSns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:34:21 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-zfoRk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:34:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:34:21 INFO - Running setup.py install for manifestparser 12:34:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:34:21 INFO - Running setup.py install for mozcrash 12:34:21 INFO - Running setup.py install for mozdebug 12:34:21 INFO - Running setup.py install for mozdevice 12:34:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:34:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:34:21 INFO - Running setup.py install for mozfile 12:34:21 INFO - Running setup.py install for mozhttpd 12:34:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Running setup.py install for mozinfo 12:34:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Running setup.py install for mozInstall 12:34:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Running setup.py install for mozleak 12:34:22 INFO - Running setup.py install for mozlog 12:34:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Running setup.py install for moznetwork 12:34:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Running setup.py install for mozprocess 12:34:22 INFO - Running setup.py install for mozprofile 12:34:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for mozrunner 12:34:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for mozscreenshot 12:34:23 INFO - Running setup.py install for moztest 12:34:23 INFO - Running setup.py install for mozversion 12:34:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:34:23 INFO - Cleaning up... 12:34:23 INFO - Return code: 0 12:34:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:23 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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:23 INFO - 'HOME': '/Users/cltbld', 12:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:23 INFO - 'LOGNAME': 'cltbld', 12:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:23 INFO - 'MOZ_NO_REMOTE': '1', 12:34:23 INFO - 'NO_EM_RESTART': '1', 12:34:23 INFO - 'PAGER': '/bin/cat', 12:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:23 INFO - 'PWD': '/builds/slave/test', 12:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:23 INFO - 'SHELL': '/bin/bash', 12:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:23 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:23 INFO - 'USER': 'cltbld', 12:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:23 INFO - 'XPC_FLAGS': '0x0', 12:34:23 INFO - 'XPC_SERVICE_NAME': '0', 12:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-NzSuWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-SWjBLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:24 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)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-KxHpbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-dWOxPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Sk8Nv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-y41eWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-pzHnea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-FdeRDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:24 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-8yiF2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:25 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-52KiFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:25 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ix_fEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:25 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-GMhGxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:34:25 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-yMWK1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:34:25 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Tl1uaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:25 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-3f3Zdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:34:25 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-XbAHsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:34:25 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-HfhNsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:34:25 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)) 12:34:25 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)) 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:34:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:28 INFO - Downloading blessings-1.6.tar.gz 12:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:34:28 INFO - Installing collected packages: blessings 12:34:28 INFO - Running setup.py install for blessings 12:34:28 INFO - Successfully installed blessings 12:34:28 INFO - Cleaning up... 12:34:28 INFO - Return code: 0 12:34:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:34:28 INFO - Reading from file tmpfile_stdout 12:34:28 INFO - Current package versions: 12:34:28 INFO - blessings == 1.6 12:34:28 INFO - blobuploader == 1.2.4 12:34:28 INFO - docopt == 0.6.1 12:34:28 INFO - manifestparser == 1.1 12:34:28 INFO - mozInstall == 1.12 12:34:28 INFO - mozcrash == 0.16 12:34:28 INFO - mozdebug == 0.1 12:34:28 INFO - mozdevice == 0.48 12:34:28 INFO - mozfile == 1.2 12:34:28 INFO - mozhttpd == 0.7 12:34:28 INFO - mozinfo == 0.9 12:34:28 INFO - mozleak == 0.1 12:34:28 INFO - mozlog == 3.1 12:34:28 INFO - moznetwork == 0.27 12:34:28 INFO - mozprocess == 0.22 12:34:28 INFO - mozprofile == 0.28 12:34:28 INFO - mozrunner == 6.11 12:34:28 INFO - mozscreenshot == 0.1 12:34:28 INFO - mozsystemmonitor == 0.0 12:34:28 INFO - moztest == 0.7 12:34:28 INFO - mozversion == 1.4 12:34:28 INFO - psutil == 3.1.1 12:34:28 INFO - requests == 1.2.3 12:34:28 INFO - wsgiref == 0.1.2 12:34:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:28 INFO - 'HOME': '/Users/cltbld', 12:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:28 INFO - 'LOGNAME': 'cltbld', 12:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:28 INFO - 'MOZ_NO_REMOTE': '1', 12:34:28 INFO - 'NO_EM_RESTART': '1', 12:34:28 INFO - 'PAGER': '/bin/cat', 12:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:28 INFO - 'PWD': '/builds/slave/test', 12:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:28 INFO - 'SHELL': '/bin/bash', 12:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:28 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:28 INFO - 'USER': 'cltbld', 12:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:28 INFO - 'XPC_FLAGS': '0x0', 12:34:28 INFO - 'XPC_SERVICE_NAME': '0', 12:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:34:29 INFO - Cleaning up... 12:34:29 INFO - Return code: 0 12:34:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:29 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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:29 INFO - 'HOME': '/Users/cltbld', 12:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:29 INFO - 'LOGNAME': 'cltbld', 12:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:29 INFO - 'MOZ_NO_REMOTE': '1', 12:34:29 INFO - 'NO_EM_RESTART': '1', 12:34:29 INFO - 'PAGER': '/bin/cat', 12:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:29 INFO - 'PWD': '/builds/slave/test', 12:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:29 INFO - 'SHELL': '/bin/bash', 12:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:29 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:29 INFO - 'USER': 'cltbld', 12:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:29 INFO - 'XPC_FLAGS': '0x0', 12:34:29 INFO - 'XPC_SERVICE_NAME': '0', 12:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:29 INFO - Downloading/unpacking jsonschema 12:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:34:31 INFO - Downloading/unpacking functools32 (from jsonschema) 12:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:32 INFO - Downloading functools32-3.2.3-2.tar.gz 12:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:34:32 INFO - warning: no files found matching '*.txt' 12:34:32 INFO - no previously-included directories found matching 'build' 12:34:32 INFO - no previously-included directories found matching 'dist' 12:34:32 INFO - no previously-included directories found matching '.git*' 12:34:32 INFO - Installing collected packages: jsonschema, functools32 12:34:32 INFO - Running setup.py install for functools32 12:34:32 INFO - warning: no files found matching '*.txt' 12:34:32 INFO - no previously-included directories found matching 'build' 12:34:32 INFO - no previously-included directories found matching 'dist' 12:34:32 INFO - no previously-included directories found matching '.git*' 12:34:32 INFO - Successfully installed jsonschema functools32 12:34:32 INFO - Cleaning up... 12:34:32 INFO - Return code: 0 12:34:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:32 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 0x108247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10824f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb50caefd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, '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.cIHxIYufjW/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.LlXzcyzs2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:32 INFO - 'HOME': '/Users/cltbld', 12:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:32 INFO - 'LOGNAME': 'cltbld', 12:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:32 INFO - 'MOZ_NO_REMOTE': '1', 12:34:32 INFO - 'NO_EM_RESTART': '1', 12:34:32 INFO - 'PAGER': '/bin/cat', 12:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:32 INFO - 'PWD': '/builds/slave/test', 12:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:32 INFO - 'SHELL': '/bin/bash', 12:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:34:32 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:32 INFO - 'USER': 'cltbld', 12:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:32 INFO - 'XPC_FLAGS': '0x0', 12:34:32 INFO - 'XPC_SERVICE_NAME': '0', 12:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:32 INFO - Downloading/unpacking flake8 12:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:34:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:34:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:34:36 INFO - no previously-included directories found matching 'docs/_build' 12:34:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:34:36 INFO - Running setup.py install for pep8 12:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:34:36 INFO - no previously-included directories found matching 'docs/_build' 12:34:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:34:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:34:36 INFO - Cleaning up... 12:34:36 INFO - Return code: 0 12:34:36 INFO - Running post-action listener: _resource_record_post_action 12:34:36 INFO - Running post-action listener: _start_resource_monitoring 12:34:36 INFO - Starting resource monitoring. 12:34:36 INFO - ##### 12:34:36 INFO - ##### Running install step. 12:34:36 INFO - ##### 12:34:36 INFO - Running pre-action listener: _resource_record_pre_action 12:34:36 INFO - Running main action method: install 12:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:34:37 INFO - Reading from file tmpfile_stdout 12:34:37 INFO - Detecting whether we're running mozinstall >=1.0... 12:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:34:37 INFO - Reading from file tmpfile_stdout 12:34:37 INFO - Output received: 12:34:37 INFO - Usage: mozinstall [options] installer 12:34:37 INFO - Options: 12:34:37 INFO - -h, --help show this help message and exit 12:34:37 INFO - -d DEST, --destination=DEST 12:34:37 INFO - Directory to install application into. [default: 12:34:37 INFO - "/builds/slave/test"] 12:34:37 INFO - --app=APP Application being installed. [default: firefox] 12:34:37 INFO - mkdir: /builds/slave/test/build/application 12:34:37 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'] 12:34:37 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 12:35:10 INFO - Reading from file tmpfile_stdout 12:35:10 INFO - Output received: 12:35:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:35:10 INFO - Running post-action listener: _resource_record_post_action 12:35:10 INFO - ##### 12:35:10 INFO - ##### Running run-tests step. 12:35:10 INFO - ##### 12:35:10 INFO - Running pre-action listener: _resource_record_pre_action 12:35:10 INFO - Running main action method: run_tests 12:35:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:35:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:35:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:35:10 INFO - 2016-02-15 12:35:10.850 screenresolution[1654:7458] starting screenresolution argv=screenresolution get 12:35:10 INFO - 2016-02-15 12:35:10.853 screenresolution[1654:7458] Display 0: 1600x1200x32@60 12:35:10 INFO - 2016-02-15 12:35:10.859 screenresolution[1655:7460] starting screenresolution argv=screenresolution list 12:35:10 INFO - Available Modes on Display 0 12:35:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:35:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:35:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:35:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:35:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:35:11 INFO - Intel Iris: 12:35:11 INFO - Chipset Model: Intel Iris 12:35:11 INFO - Type: GPU 12:35:11 INFO - Bus: Built-In 12:35:11 INFO - VRAM (Dynamic, Max): 1536 MB 12:35:11 INFO - Vendor: Intel (0x8086) 12:35:11 INFO - Device ID: 0x0a2e 12:35:11 INFO - Revision ID: 0x0009 12:35:11 INFO - Displays: 12:35:11 INFO - Display: 12:35:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:35:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:35:11 INFO - Display Serial Number: 1600x1200 60 12:35:11 INFO - Main Display: Yes 12:35:11 INFO - Mirror: Off 12:35:11 INFO - Online: Yes 12:35:11 INFO - Rotation: Supported 12:35:11 INFO - Return code: 0 12:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:11 INFO - Python 2.7.3 12:35:11 INFO - Return code: 0 12:35:11 INFO - grabbing minidump binary from tooltool 12:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:11 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 0x1080ebd30>, '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 0x107f0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080e2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:35:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:35:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:11 INFO - Return code: 0 12:35:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:35:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:35:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:35:12 INFO - Return code: 0 12:35:12 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/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:35:12 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/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cIHxIYufjW/Render', 12:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:12 INFO - 'HOME': '/Users/cltbld', 12:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:12 INFO - 'LOGNAME': 'cltbld', 12:35:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:12 INFO - 'MOZ_NO_REMOTE': '1', 12:35:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:12 INFO - 'NO_EM_RESTART': '1', 12:35:12 INFO - 'PAGER': '/bin/cat', 12:35:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:12 INFO - 'PWD': '/builds/slave/test', 12:35:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:12 INFO - 'SHELL': '/bin/bash', 12:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LlXzcyzs2y/Listeners', 12:35:12 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 12:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:12 INFO - 'USER': 'cltbld', 12:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:12 INFO - 'XPC_FLAGS': '0x0', 12:35:12 INFO - 'XPC_SERVICE_NAME': '0', 12:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:12 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/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:35:12 INFO - mozversion application_buildid: 20160215113721 12:35:12 INFO - mozversion application_changeset: 51577bed9ade8703bd80b7a0efa90d3c24d5bd52 12:35:12 INFO - mozversion application_display_name: Nightly 12:35:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:12 INFO - mozversion application_name: Firefox 12:35:12 INFO - mozversion application_remotingname: firefox 12:35:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:35:12 INFO - mozversion application_vendor: Mozilla 12:35:12 INFO - mozversion application_version: 47.0a1 12:35:12 INFO - mozversion platform_buildid: 20160215113721 12:35:12 INFO - mozversion platform_changeset: 51577bed9ade8703bd80b7a0efa90d3c24d5bd52 12:35:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:35:12 INFO - mozversion platform_version: 47.0a1 12:35:12 INFO - using testdate: 1455568512 12:35:12 INFO - actual date: 1455568512 12:35:13 INFO - starting webserver on 'localhost:49275' 12:35:13 INFO - SUITE-START | Running 2 tests 12:35:13 INFO - TEST-START | dromaeo_css 12:35:13 INFO - operating with platform_type : mac_ 12:35:13 INFO - Initialising browser for dromaeo_css test... 12:35:13 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpMxqvGR/profile http://localhost:49275/getInfo.html) 12:35:15 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 12:35:15 INFO - PROCESS | 1673 | colorDepth:24 12:35:15 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 12:35:15 INFO - PROCESS | 1673 | __metrics 12:35:15 INFO - PROCESS | 1673 | 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" 12:35:15 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:16 INFO - TEST-INFO | 1673: exit 0 12:35:16 INFO - Browser initialized. 12:35:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:16 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpMxqvGR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:27 INFO - PROCESS | 1676 | RSS: Main: 245788672 12:35:27 INFO - PROCESS | 1676 | 12:36:19 INFO - PROCESS | 1676 | 1455568579245 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:38:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 12:38:31 INFO - PROCESS | 1676 | RSS: Main: 365285376 12:38:31 INFO - PROCESS | 1676 | 12:41:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 12:41:34 INFO - PROCESS | 1676 | RSS: Main: 382758912 12:41:34 INFO - PROCESS | 1676 | 12:44:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 12:44:37 INFO - PROCESS | 1676 | RSS: Main: 378392576 12:44:37 INFO - PROCESS | 1676 | 12:47:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 12:47:39 INFO - PROCESS | 1676 | RSS: Main: 368295936 12:47:39 INFO - PROCESS | 1676 | 12:50:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 12:50:43 INFO - PROCESS | 1676 | RSS: Main: 339873792 12:50:43 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 12:53:46 INFO - PROCESS | 1676 | RSS: Main: 448901120 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | __start_tp_report 12:53:46 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 12:53:46 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 12:53:46 INFO - PROCESS | 1676 | |i|pagename|runs| 12:53:46 INFO - PROCESS | 1676 | |0;dojo.html;3139.246580820603;3329.2176338560434;3448.6378930212327;3468.462388329809;3471.5660542432197;5534.778608855641;5574.693391863446;5578.470045345696;5643.6049476536655;5655.1517272409155;5639.407862174464;5669.09294512878;5728.398518155585;5761.251037365137;5769.942300576993;5101.489851014906;5155.072087024343;5162.92255616166;5184.403793563751;5279.208118782175;5277.366715994086;5283.471652834724;5322.121849894782;5333.2000199969925;5358.2498450217;5080.314157588715;5086.237064440326;5178.404483484373;5198.2722418861385;5230.92153617696;5159.277701121846;5188.610854185951;5199.038177937094;5202.3497062867145;5211.03595834768;5108.310378098983;5146;5160.638755287131;5167.689938603658;5171.4052883918075;5422.43064478228;5486.753096110685;5514.007478653841;5580.720963951786;5628.127640215773;6204.47261982732;6204.81385558434;6224.906626400608;6241.78153764616;6252.749890004395;5842.912356314659;6082.986972859288;6237.1388284064515;6265.0915617235705;6292.4966002719675;5760.510356619692;5780.942190578125;5798.59409841307;5835.153902684087;5906.468417842372;6245.6252624842655;6252.406021427957;6257.624542527463;6277.121203031579;6281.560290779602;5376.247325374451;5667.291588551431;6129.509639228851;6132.969335153296;6134.78528251509;6166.784162554289;6240.906386404207;6246.469050130699;6262.561620686508;6271.090691849657;5159.948400516022;6154.692265386713;6192.133101365813;6197.721102550306;6201.131841542187;6075.422834830772;6163.19878415812;6177.62934223939;6223.844403889939;6238.937610623926;4146.751194928253;4808.663393562487;4820.373351464287;4853.12643724126;4874.341963834908;4328.675349348811;4424.336349547593;4442.511323754385;4459.531749166355;4461.04087621163;5478.534324582375;5537.972310138423;5544.362398324244;5549.19536667181;5576.191452239484;6225.750969961241;6228.439440450381;6241.375862413723;6242.282137554149;6247.437730604267;5474.808381706701;5573.442655734394;5585.832425027255;5637.605367624309;5687.488126068591;5348.679079255257;5348.786048558014;5366.731663416814;5369.624126311199;5370.4629537045985;6156.230471191101;6259.96870015647;6272.874542509216;6299.590526615755;6318.273398559132;6150.138980542638;6170.382961703794;6276.403741644536;6282.120503129657;6282.937170628235;6219.253689557101;6251.249850018027;6272.717727702356;6277.968610157102;6285.685715714105;5995.970020149872;6126.417990290915;6173.444390004921;6178.073289006685;6187.752489900534;6151.32335443092;6256.906146407899;6266.216722909637;6277.372262773686;6280.968595157177;5860.472557469848;6037.0642550404755;6046.54650901193;6060.939390606038;6105.572609917441;5699.116636921284;5840.853978650568;6008.909866351921;6010.459058684739;6066.969665151646;5889.087191485327;5914.201582786269;5937.406259374028;5944.375840536682;5946.167536544801;6039.607425517327;6048.4858787003595;6081.087836824335;6086.178365920544;6122.448979591858;5751.8562035949435;5866.882662346815;5884.882302354014;5934.19888315072;6036.064410016279 12:53:46 INFO - PROCESS | 1676 | |1;ext.html;455.7151780137414;462.96989199032157;491.45694008121023;558.196197475635;571.9847271093807;30635.08094757158;38812.64155754549;39443;39480.80259598698;39481;43620;44114.338284925754;44170.77914610422;44224.3366349505;44385;9714.708558743232;9944.950275248613;9955.203583713323;9956.253281003917;9963.601455941754;9849.21206303494;9988.650397236099;9995.900040999606;10001.299909006373;10006.799864002716;9956.75108122299;10018.398896066223;10020.997900209994;10030.247731420173;10037.34757240777;9904.306698531105;9984.151347135503;10005.999400060009;10018.3488073275;10018.849717254247;9734.756631084208;9892.653757118467;9897.703068907944;9903.405795652285;9904.356216845881;40394.19211615781;40727.592724072674;40840.591594084275;40869.591304087175;40939.7953010236;3162.1936406216496;3168.936621267585;3179.332340208559;3218.082846388768;3389.864405423805;28428.28929276764;29066.5293450057;29201.561976570367;29275.8289668413;29392.706072939425;2399.7120345558646;2817.2534278416033;2858.8856445742144;2884.4663737208475;2978.166113488227;455328;457311;457796.7110164428;458335.9999999967;458373;57963.84072318614;59184.7040764802;65851.34148658453;71106.57786844234;71568.2843171572;68123;68622.65688671525;68809.65595171992;68849.3115068853;69061.65469172622;13805.171689698449;16543.503694889172;16776.825622206572;16797.916010420115;16842.83157168437;10557.208209384327;11551.364674942959;11727.88272117285;12649.304288264233;12813.551525696555;20323.898380508002;20590.382288531368;20608.896955515127;20612.484687882625;20641.79358206429;7854.879182620774;7945.602719863984;7978.401619878532;8040.798980025546;8071.313938315191;940.2431043010306;943.4527973775193;962.3744566031995;970.8203982263162;1020.9438480883474;30162.24594385158;31346.21634459157;31622.841885790425;31763.42713547773;32332.35335293328;1051.395447617623;1081.8972197641212;1090.8636420447444;1105.1545567640762;1155.2490880927464;13472.730545389037;13977.161370317814;14036.43854245839;14259.643508912153;14295.428182872776;423624;427482;427697;427866;429325;54766.72616636891;54869.72565137149;55007.72496137574;55049.1742623861;55172.448275517534;1403.7753959366453;1418.6737050478448;1431.055503367793;1435.8061661675958;1436.3608194353621;27805.860970695827;27971.756170240365;28362.72367743415;28374.716252837206;28451.715482844906;49535;49954.00091998067;49959.75020124876;49991;50027.499725002286;434976;440461;444734;627229;639592;30717.539236911016;31048.379032419678;31081.067567972997;31083.68916310808;31116.688833112286;43902.682919511186;44516.77741611271;44523.777381112886;45152.32271515864;45733.08533829238;36283.818580906925;36658.816705917365;36875.89372318835;37016.25967480581;37093.443598345504;30922.0723378299;36358.636413635526;36854.44718329173;37203.62796372001;37334.439983400815;36121.916342509765;37161.81419092995;37276.440853387765;37585.624143758214;37615.05962350854;30368;33073;33093;33136.17159570933;33155.83422082874;24107.397315067265;24377.51244975126;24719.25842224736;24757.381065473506;25245.368865778502 12:53:46 INFO - PROCESS | 1676 | |2;jquery.html;365.12734564391104;366.7689355705905;368.55773072313224;370.3999520776343;373.95325584301963;15337.539873803777;15384.233961740221;18567.628647427042;19544.706829397554;20145.899270503665;19972.50068748282;20148.798512014877;20464.07911643976;21105.366838994854;21109.261175858846;3950.4666869972616;6215.658138802352;6493.285738568778;6504.414602685757;6509;4664.906701865961;6936.826579335507;7220.963895180516;7224.963875180617;7245.4928155029165;6802.183737951453;7167.426605871544;7168.85662286754;7178.353948144666;7179.389751871097;6788.898166527506;7026.613536255504;7049.330313620198;7056.04743359645;7069.611171385572;6650.068990341356;6723.596584204964;6742.4268937140405;6749.797506074826;6961.547499412522;26131.869340653364;26190;26364.077257295903;26481.470370592673;26707.599386009224;2171.4137182960512;2189.2665956904457;2215.5314997672663;2251.8761468119246;2315.9189428370096;14587.270636468134;14736.55790326292;14987.850121498754;15191.581894073855;15616.297266623029;1551.1313664347888;1837.80703026183;1930.0639189992842;1958.6180694764528;1963.2147141143514;75825.86261206087;89227.99999999935;90096;90735;92394.5380273101;10829.67510974672;11054.778904422028;11080.412248183717;11081.335119892832;11087;13155.73688526224;13165.868341316656;13222.735545289233;13258.73482530344;13317.200967941955;6760.391564759097;8336.541490218096;8340.499570025819;8401.15988401155;8421.621027053798;6849.828754281183;8455.196756308142;8475.618597163018;8491.957540212383;8571.571421428904;4054.4729185205733;4179.185058913483;4182.142660754538;4188.371744238328;4324.308110702273;1740.4343588333843;1784.4468214853177;3205.919852003672;3411.8976430707116;3417.1296111266656;867.9783005424915;894.615315414365;943.3962264150949;996.8056229035268;1010.7372083258259;18176.92069794569;18689.972051537025;18756;19773.60452790936;20234.595308093754;787.5117427195061;975.22956864078;1006.2352612014776;1018.5518371916334;1025.4513835098187;9015.909840901639;10539.736506587396;11253.268537545033;11281.435928203557;11300.265482743594;579766;581985;589858;633763;642189.7890510517;69855.65072174606;71536.64231678809;94491.52754236184;110433.89566104236;121082.39458802826;1137.4881303413497;1158.2992289664633;1171.4494187731752;1179.3690375648987;1181.5982565927625;17775.91112044483;17969;18106.378724254937;18111.547211319823;18509.81490185081;31776.364472709953;38828.41757373585;48899.02201956012;49323;51953.15617269269;71141.64429177821;71370;71680;71785.6410717943;72264.63867680628;7284.235155308616;7518.473706840468;7523.1348394935285;7523.88714169277;7566.24337566239;9415.529223538933;10572.41851698164;11524.827127592926;11787.823182652439;12075.939620301842;10178.949105254427;10306.793864122825;10384.844227336445;10519.631812886511;10532.36805791655;8538.487690738575;10199.7450063749;10469.31949423285;10494.52774625159;10816.945915270688;8520.573971301534;10700.197485188486;10829.512671929624;10857.34855908648;11008.779824403628;7472.36484898768;7529.13414957265;7622.885656715264;7646.655900484603;7647.273509016634;8165.632546535301;10344.27590068688;10633;10816.296940698829;10829.404382759023 12:53:46 INFO - PROCESS | 1676 | |3;mootools.html;1336.4186578838203;1390.7427125981687;1514.7879296898432;1707.6413953069855;1906.723525088863;7855.1752066033105;8426.325893928486;8554;8557.871631925518;8571.214355334525;8325.625346859391;8613.698520551781;8615.612297446614;8622.525761083138;8628.309735221183;2212.8451008429415;2273.2157405695093;2485.7017157941073;2514.8742562871785;2517.2196619048063;2477.2692055843568;2531.392465808202;2532.025170309435;2535.2394281715506;2536.6321883326905;2391.1869964212165;2487.4900645367657;2496.8252222344445;2497.8751062446804;2503.0238207099246;2466.136852101768;2481.2928315430104;2501.312139161727;2501.8498890066653;2506.147909710689;2464.0759715106833;2476.418041760185;2495.7254701982765;2507.3480894967256;2514.4719608882156;8583.184597463294;8623.439476434012;8626.137386261387;8631.395802293842;8631.913680863174;5379.1393377059485;5508.3114610673665;5515.338159420895;5538.501534861882;5545.140503222007;3635.1820840310984;3651.415773476231;3717.6839968602703;3738.5700644425965;3751.3997760358484;1043.984340234897;1057.8148823955853;1060.777236780277;1090.6019302954444;1096.199774164864;11662.59180928672;11697;11906.404679766063;11919.582814601446;11945.984591309749;4912.557869791736;4922.990786888679;4973.502649734997;5010.448850626428;5015.3229314042865;10318.587256509805;10325;10333.638322658671;10336.5348559315;10346.120579750805;4591.334256532784;5381.408045115034;5534.418886016991;5560.86097847549;5561.054620714488;4871.683340582851;4914.631402644816;4950.727709975986;5029.471905449948;5035.597152227813;3712.3503386907723;3759.473673685686;3762.736608437383;3770.3967365221433;3822.1782316802023;1236.3014896583402;1314.5859054397833;1316.3878796359738;1325.9734805304033;1333.3533236380347;1296.9610911672664;1306.8954483641287;1308.7447947650307;1347.5889853594747;1351.2770667692737;7885.605719713992;7946.880796788053;7992.640331185111;8001.959745233083;8006.799830004296;1174.5595401724354;1177.988220117805;1186.649938268213;1190.458341454636;1198.8920997110301;6113.32753397126;6221.47117495018;6228.781992630236;6246.375362463808;6254.874902501924;10079.49602519871;10232.795344093225;10242.53908574116;10275.897241027495;10387.169026478015;9868.161206297402;10138.239632027628;10140.087392134596;10269.332493387907;10284.897151028543;7909.406794490436;7966;8002.959985200153;8035.638396272298;8036.316913062456;7662.118856331594;7773.611319434119;7886.921130788848;7915.485493442908;7962.880556791769;9362.344635875696;9381.437113773196;9403.106704863027;9532.23742100644;9548.283878709264;9404.95297523508;9800.65697700577;9808.852867206855;9835.754106147117;9858.802823943624;6143.354947730424;7275.781726548212;7311.976323314847;7395.852082958203;7406.111266648037;7193.064901562763;7912.920870791449;7985;8018.919810801817;8099.934516698204;6772.661366931732;6839.110915580943;7384.298491643285;7537.472376933562;7722.150563437905;6230.470410015018;7403.407727381904;7574.886376704464;7595.658195381111;7614.885776713464;7541.585212813348;7580.734674286374;7624.161342252459;7624.390048796194;7656.310932016146;6903.75836845708;6955.617441040589;6962.582245065312;6963.268856770169;6968.547044442095;6948.722051117898;6987.7204911802955;6998.860022799414;7004.229534751072;7130.750423735144 12:53:46 INFO - PROCESS | 1676 | |4;prototype.html;316.92710676544397;323.75071195179714;326.34893387691557;327.81478464667464;330.7453260989037;6592.703328350224;6595.373439523243;6602.570832895858;6623.735050597977;6633.568818026831;6486.448651864597;6567.981962795774;6578;6587.7035533400995;6607.273199948002;4877.268409738541;4899.461059283476;4907.312976183337;4909.3126962225315;4912.975435122819;4754.7147171169845;4895.437024742165;4898.926516102261;4923.163062279403;4941.678790878599;4110.753354798707;4629.120467111255;4821.517848215186;4829.51704829516;4838.588719958808;3845.8653947111716;4609.400777898885;4708.176069187878;4835.2505361669;4837.105135549917;4076.5923407659293;4104.1381309924955;4134.276501612236;4138.503379594438;4140.585941405865;5105.489451054902;6324;6339.873202535923;6348.460380867632;6349.396807303345;5407.351117865881;5508.641938274;5512.6692398456225;5571.749271282802;5733.770649174028;6791.3548212919695;6819.795406137824;7031.542949708252;7059.611721355323;7077.787666370017;3975.185087057146;4620.422447194101;4626.629869610423;4632.795473176964;4641.883952901205;7264.164621068592;7437.776866693954;7453.136715821045;7470.514416562906;7474.626268686544;4757;4762.78567464465;4766.022965292176;4766.737829419415;4783.928241076386;3978.8209530571194;4831.637627177975;4846.345743324677;4856.587190088811;4860.270959356125;4582.518835522289;5559.555235581144;5701.572382071361;5713.885722285531;5728.054870946247;5728.77084916607;7100.147982242164;7132.322429369202;7136.6431678415875;7138.643067846587;1652.5290292266645;1688.6200604863807;1690.4252554131654;1691.1713260502265;1693.102655592538;1093.4040947683532;1102.0687519046394;1108.728361551425;1116.5757012335423;1127.8590176227972;6606.306337834458;6613.933860661428;6614.900776488356;6623.701933413008;6635.469162466991;7365.15300740411;7378;7383.630818459055;7383.852322953511;7395.556266624019;6365.96817015912;6599.175103112111;6608.933910660832;6608.966955165193;6611.603303801788;3870.4774855394726;3914.8434062637175;3917.4515567820526;3921.862734804325;3927.19492504036;7620;7659.387249020065;7670.0795904491815;7675.385969122457;7685.346745526581;6126.172966649535;7137.607431591208;7167.569945803269;7573.697052117854;7627;7533.623318834037;7644.6942122315595;7653.043369578802;7655.961720191363;7682.423818213544;7416.221296763762;7461.813454663677;7463.888041679488;7478.962605186939;7482.176960534446;7047.189573199148;7207.927920720936;7226.783196504113;7231.8553628928175;7314.926850731425;6249.25008998923;7636.923630763621;7644.961775191088;7709.267619576131;7756.108047574601;3979.8060581825916;4587.449506059294;4597.42532183477;4674.182018146878;4685.250359942393;7118.181409138016;7299.087614048244;7385.889211661937;7409.184989651027;7410.4442166836625;7144.499885007999;7145.1068616422945;7151.32062454066;7152.177499587614;7169.5698258104685;6953.79138625842;7097.148342198969;7124.862541237711;7133.464990125865;7155.212926577969;6914.654267286716;6962.443004559725;6964.860702786017;6970.337817907291;6977.232504424611;5785.768569257182;7130.073090498202;7133.750318738819;7149.392301654418;7149.964250178716;6784.118064651564;7001.824954376181;7009.228984811564;7019.508634395544;7024.5082844200415 12:53:46 INFO - PROCESS | 1676 | |5;yui.html;684.7021545627653;716.5987047253535;741.2143128284017;751;780.6213986216684;14913.478028269014;15120.941534092617;15124.243787810621;15125.319360628771;15137.24313784312;11868.109891758131;12397.628071157857;12424.130310878241;12724.872751272485;12733.681657958556;846.3863698818369;865.5109862927458;866.7183165471215;866.7443104284251;868.9044205137461;851.1360968616827;862.5859587398053;866.8223014282057;867.4188293843109;868.4658934755143;889.8220355928808;905.1355955062932;907.4509921497498;907.7231444409452;911.0934620053057;887.6626881784913;898.7258886039755;900.7612982559627;902.6073657958743;902.9638814447414;662.2086606505228;667.0494545272967;672.8923372260415;674.6053558668185;674.912261406019;12821.102522823407;12871.613851584467;12876.484940602364;12900.935495322557;12979.805302920464;11312.09503239747;11363.602273920373;11419.828702569468;11456.828147577793;11833.822492662617;9564.952175239148;9591.184749296319;9632.951835240849;9683;9763.853542196874;3445.4831775233665;3458.4466485362223;3467.687908088284;3482.669146431085;3593.245418462126;62799.6860015697;76886;79445.60277198577;80567;80732.59633701852;7585.658645360972;8125.431219814556;9394.671186508576;9481.573329200202;9560.808783824285;19935.700964485546;20125.09437075335;20145.899270503847;20211.393658190278;20244;7438.256174382518;7479.962600186965;7560.810979725551;7666.080070391588;7807.726729564438;4085.264652362603;4098.774567398762;4108.36320370343;4126.339785634284;4139.8965025874595;3509.7543171978227;3567.35787558242;3569.089882080053;3569.5181150544863;3573.6962358199326;637.6907200007993;645.2901808011244;648.503894520692;669.581511555278;671.3051991189096;475.4508542633264;562.4825160852026;594.2393736017904;638.4477427025682;647.252423450915;8345.374096942633;8603.440776349516;8614.698485552975;8627;8783.956080219687;516.6564234783901;542.9371114358622;554.5923746046652;572.7766171193238;610.6122612141234;3975.1254723960683;3992.6007399259843;4026.5570787213383;4028.436018957348;4135.048938744106;93806.53096734473;95650;96524.55213171808;96564;96626.51686741521;73283.1679208024;80233;80900.59549702214;81224.59387703142;81698.59150704209;57844.71077644585;65325.34674653288;65953;66119.00821487681;66975;7908.248716371935;7926.445148839526;8967.686130985385;9032.277417806428;9203.631854725736;49174.50825491699;49264.75367623139;49448.50551494439;50317.49682503128;50593.73515662138;61680.69159654173;70168.64915675389;72891.27108728845;74573.2542674588;77102.61448692721;10917.945410272898;10957.342559446459;11009.284396514522;11147.498362573542;11450.484728187084;11881.1089168311;12297.200681955645;12342.81485777696;12457.750844983231;12627.873721263037;11163;11372.715682108013;11493.942530287295;11677.06583473337;11722.70693232676;11192.272502287326;11719.062475001809;11721.06231501495;11782.057435405319;12280.938595306967;9327.906720932704;11101.833472498081;11232.3260604364;11618.6514404568;11646.475908583965;9121.77195570116;9254.861177082485;9469.10043545862;9591.28065395112;10171.23715721309;8840.911590884009;9115.134062264075;9283.72148835509;9438.811223775623;9884.25868059884 12:53:46 INFO - PROCESS | 1676 | __end_tp_report 12:53:46 INFO - PROCESS | 1676 | __start_cc_report 12:53:46 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1050 12:53:46 INFO - PROCESS | 1676 | __end_cc_report 12:53:46 INFO - PROCESS | 1676 | __startTimestamp1455569626335__endTimestamp 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | ------- Summary: start ------- 12:53:46 INFO - PROCESS | 1676 | Number of tests: 6 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5689.65 Median:5866.88 stddev:641.57 (10.9%) stddev-sans-first:611.54 12:53:46 INFO - PROCESS | 1676 | Values: 3139.2 3329.2 3448.6 3468.5 3471.6 5534.8 5574.7 5578.5 5643.6 5655.2 5639.4 5669.1 5728.4 5761.3 5769.9 5101.5 5155.1 5162.9 5184.4 5279.2 5277.4 5283.5 5322.1 5333.2 5358.2 5080.3 5086.2 5178.4 5198.3 5230.9 5159.3 5188.6 5199.0 5202.3 5211.0 5108.3 5146.0 5160.6 5167.7 5171.4 5422.4 5486.8 5514.0 5580.7 5628.1 6204.5 6204.8 6224.9 6241.8 6252.7 5842.9 6083.0 6237.1 6265.1 6292.5 5760.5 5780.9 5798.6 5835.2 5906.5 6245.6 6252.4 6257.6 6277.1 6281.6 5376.2 5667.3 6129.5 6133.0 6134.8 6166.8 6240.9 6246.5 6262.6 6271.1 5159.9 6154.7 6192.1 6197.7 6201.1 6075.4 6163.2 6177.6 6223.8 6238.9 4146.8 4808.7 4820.4 4853.1 4874.3 4328.7 4424.3 4442.5 4459.5 4461.0 5478.5 5538.0 5544.4 5549.2 5576.2 6225.8 6228.4 6241.4 6242.3 6247.4 5474.8 5573.4 5585.8 5637.6 5687.5 5348.7 5348.8 5366.7 5369.6 5370.5 6156.2 6260.0 6272.9 6299.6 6318.3 6150.1 6170.4 6276.4 6282.1 6282.9 6219.3 6251.2 6272.7 6278.0 6285.7 5996.0 6126.4 6173.4 6178.1 6187.8 6151.3 6256.9 6266.2 6277.4 6281.0 5860.5 6037.1 6046.5 6060.9 6105.6 5699.1 5840.9 6008.9 6010.5 6067.0 5889.1 5914.2 5937.4 5944.4 5946.2 6039.6 6048.5 6081.1 6086.2 6122.4 5751.9 5866.9 5884.9 5934.2 6036.1 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:61800.55 Median:37182.72 stddev:125445.44 (337.4%) stddev-sans-first:125712.80 12:53:46 INFO - PROCESS | 1676 | Values: 455.7 463.0 491.5 558.2 572.0 30635.1 38812.6 39443.0 39480.8 39481.0 43620.0 44114.3 44170.8 44224.3 44385.0 9714.7 9945.0 9955.2 9956.3 9963.6 9849.2 9988.7 9995.9 10001.3 10006.8 9956.8 10018.4 10021.0 10030.2 10037.3 9904.3 9984.2 10006.0 10018.3 10018.8 9734.8 9892.7 9897.7 9903.4 9904.4 40394.2 40727.6 40840.6 40869.6 40939.8 3162.2 3168.9 3179.3 3218.1 3389.9 28428.3 29066.5 29201.6 29275.8 29392.7 2399.7 2817.3 2858.9 2884.5 2978.2 455328.0 457311.0 457796.7 458336.0 458373.0 57963.8 59184.7 65851.3 71106.6 71568.3 68123.0 68622.7 68809.7 68849.3 69061.7 13805.2 16543.5 16776.8 16797.9 16842.8 10557.2 11551.4 11727.9 12649.3 12813.6 20323.9 20590.4 20608.9 20612.5 20641.8 7854.9 7945.6 7978.4 8040.8 8071.3 940.2 943.5 962.4 970.8 1020.9 30162.2 31346.2 31622.8 31763.4 32332.4 1051.4 1081.9 1090.9 1105.2 1155.2 13472.7 13977.2 14036.4 14259.6 14295.4 423624.0 427482.0 427697.0 427866.0 429325.0 54766.7 54869.7 55007.7 55049.2 55172.4 1403.8 1418.7 1431.1 1435.8 1436.4 27805.9 27971.8 28362.7 28374.7 28451.7 49535.0 49954.0 49959.8 49991.0 50027.5 434976.0 440461.0 444734.0 627229.0 639592.0 30717.5 31048.4 31081.1 31083.7 31116.7 43902.7 44516.8 44523.8 45152.3 45733.1 36283.8 36658.8 36875.9 37016.3 37093.4 30922.1 36358.6 36854.4 37203.6 37334.4 36121.9 37161.8 37276.4 37585.6 37615.1 30368.0 33073.0 33093.0 33136.2 33155.8 24107.4 24377.5 24719.3 24757.4 25245.4 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:32933.89 Median:3414.51 stddev:99743.31 (2921.2%) stddev-sans-first:99993.13 12:53:46 INFO - PROCESS | 1676 | Values: 365.1 366.8 368.6 370.4 374.0 15337.5 15384.2 18567.6 19544.7 20145.9 19972.5 20148.8 20464.1 21105.4 21109.3 3950.5 6215.7 6493.3 6504.4 6509.0 4664.9 6936.8 7221.0 7225.0 7245.5 6802.2 7167.4 7168.9 7178.4 7179.4 6788.9 7026.6 7049.3 7056.0 7069.6 6650.1 6723.6 6742.4 6749.8 6961.5 26131.9 26190.0 26364.1 26481.5 26707.6 2171.4 2189.3 2215.5 2251.9 2315.9 14587.3 14736.6 14987.9 15191.6 15616.3 1551.1 1837.8 1930.1 1958.6 1963.2 75825.9 89228.0 90096.0 90735.0 92394.5 10829.7 11054.8 11080.4 11081.3 11087.0 13155.7 13165.9 13222.7 13258.7 13317.2 6760.4 8336.5 8340.5 8401.2 8421.6 6849.8 8455.2 8475.6 8492.0 8571.6 4054.5 4179.2 4182.1 4188.4 4324.3 1740.4 1784.4 3205.9 3411.9 3417.1 868.0 894.6 943.4 996.8 1010.7 18176.9 18690.0 18756.0 19773.6 20234.6 787.5 975.2 1006.2 1018.6 1025.5 9015.9 10539.7 11253.3 11281.4 11300.3 579766.0 581985.0 589858.0 633763.0 642189.8 69855.7 71536.6 94491.5 110433.9 121082.4 1137.5 1158.3 1171.4 1179.4 1181.6 17775.9 17969.0 18106.4 18111.5 18509.8 31776.4 38828.4 48899.0 49323.0 51953.2 71141.6 71370.0 71680.0 71785.6 72264.6 7284.2 7518.5 7523.1 7523.9 7566.2 9415.5 10572.4 11524.8 11787.8 12075.9 10178.9 10306.8 10384.8 10519.6 10532.4 8538.5 10199.7 10469.3 10494.5 10816.9 8520.6 10700.2 10829.5 10857.3 11008.8 7472.4 7529.1 7622.9 7646.7 7647.3 8165.6 10344.3 10633.0 10816.3 10829.4 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5983.81 Median:5380.27 stddev:3099.41 (57.6%) stddev-sans-first:3088.42 12:53:46 INFO - PROCESS | 1676 | Values: 1336.4 1390.7 1514.8 1707.6 1906.7 7855.2 8426.3 8554.0 8557.9 8571.2 8325.6 8613.7 8615.6 8622.5 8628.3 2212.8 2273.2 2485.7 2514.9 2517.2 2477.3 2531.4 2532.0 2535.2 2536.6 2391.2 2487.5 2496.8 2497.9 2503.0 2466.1 2481.3 2501.3 2501.8 2506.1 2464.1 2476.4 2495.7 2507.3 2514.5 8583.2 8623.4 8626.1 8631.4 8631.9 5379.1 5508.3 5515.3 5538.5 5545.1 3635.2 3651.4 3717.7 3738.6 3751.4 1044.0 1057.8 1060.8 1090.6 1096.2 11662.6 11697.0 11906.4 11919.6 11946.0 4912.6 4923.0 4973.5 5010.4 5015.3 10318.6 10325.0 10333.6 10336.5 10346.1 4591.3 5381.4 5534.4 5560.9 5561.1 4871.7 4914.6 4950.7 5029.5 5035.6 3712.4 3759.5 3762.7 3770.4 3822.2 1236.3 1314.6 1316.4 1326.0 1333.4 1297.0 1306.9 1308.7 1347.6 1351.3 7885.6 7946.9 7992.6 8002.0 8006.8 1174.6 1178.0 1186.6 1190.5 1198.9 6113.3 6221.5 6228.8 6246.4 6254.9 10079.5 10232.8 10242.5 10275.9 10387.2 9868.2 10138.2 10140.1 10269.3 10284.9 7909.4 7966.0 8003.0 8035.6 8036.3 7662.1 7773.6 7886.9 7915.5 7962.9 9362.3 9381.4 9403.1 9532.2 9548.3 9405.0 9800.7 9808.9 9835.8 9858.8 6143.4 7275.8 7312.0 7395.9 7406.1 7193.1 7912.9 7985.0 8018.9 8099.9 6772.7 6839.1 7384.3 7537.5 7722.2 6230.5 7403.4 7574.9 7595.7 7614.9 7541.6 7580.7 7624.2 7624.4 7656.3 6903.8 6955.6 6962.6 6963.3 6968.5 6948.7 6987.7 6998.9 7004.2 7130.8 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5763.86 Median:6597.27 stddev:1857.92 (28.2%) stddev-sans-first:1817.59 12:53:46 INFO - PROCESS | 1676 | Values: 316.9 323.8 326.3 327.8 330.7 6592.7 6595.4 6602.6 6623.7 6633.6 6486.4 6568.0 6578.0 6587.7 6607.3 4877.3 4899.5 4907.3 4909.3 4913.0 4754.7 4895.4 4898.9 4923.2 4941.7 4110.8 4629.1 4821.5 4829.5 4838.6 3845.9 4609.4 4708.2 4835.3 4837.1 4076.6 4104.1 4134.3 4138.5 4140.6 5105.5 6324.0 6339.9 6348.5 6349.4 5407.4 5508.6 5512.7 5571.7 5733.8 6791.4 6819.8 7031.5 7059.6 7077.8 3975.2 4620.4 4626.6 4632.8 4641.9 7264.2 7437.8 7453.1 7470.5 7474.6 4757.0 4762.8 4766.0 4766.7 4783.9 3978.8 4831.6 4846.3 4856.6 4860.3 4582.5 5559.6 5701.6 5713.9 5728.1 5728.8 7100.1 7132.3 7136.6 7138.6 1652.5 1688.6 1690.4 1691.2 1693.1 1093.4 1102.1 1108.7 1116.6 1127.9 6606.3 6613.9 6614.9 6623.7 6635.5 7365.2 7378.0 7383.6 7383.9 7395.6 6366.0 6599.2 6608.9 6609.0 6611.6 3870.5 3914.8 3917.5 3921.9 3927.2 7620.0 7659.4 7670.1 7675.4 7685.3 6126.2 7137.6 7167.6 7573.7 7627.0 7533.6 7644.7 7653.0 7656.0 7682.4 7416.2 7461.8 7463.9 7479.0 7482.2 7047.2 7207.9 7226.8 7231.9 7314.9 6249.3 7636.9 7645.0 7709.3 7756.1 3979.8 4587.4 4597.4 4674.2 4685.3 7118.2 7299.1 7385.9 7409.2 7410.4 7144.5 7145.1 7151.3 7152.2 7169.6 6953.8 7097.1 7124.9 7133.5 7155.2 6914.7 6962.4 6964.9 6970.3 6977.2 5785.8 7130.1 7133.8 7149.4 7150.0 6784.1 7001.8 7009.2 7019.5 7024.5 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18070.65 Median:32986.93 stddev:25734.93 (78.0%) stddev-sans-first:25774.02 12:53:46 INFO - PROCESS | 1676 | Values: 684.7 716.6 741.2 751.0 780.6 14913.5 15120.9 15124.2 15125.3 15137.2 11868.1 12397.6 12424.1 12724.9 12733.7 846.4 865.5 866.7 866.7 868.9 851.1 862.6 866.8 867.4 868.5 889.8 905.1 907.5 907.7 911.1 887.7 898.7 900.8 902.6 903.0 662.2 667.0 672.9 674.6 674.9 12821.1 12871.6 12876.5 12900.9 12979.8 11312.1 11363.6 11419.8 11456.8 11833.8 9565.0 9591.2 9633.0 9683.0 9763.9 3445.5 3458.4 3467.7 3482.7 3593.2 62799.7 76886.0 79445.6 80567.0 80732.6 7585.7 8125.4 9394.7 9481.6 9560.8 19935.7 20125.1 20145.9 20211.4 20244.0 7438.3 7480.0 7560.8 7666.1 7807.7 4085.3 4098.8 4108.4 4126.3 4139.9 3509.8 3567.4 3569.1 3569.5 3573.7 637.7 645.3 648.5 669.6 671.3 475.5 562.5 594.2 638.4 647.3 8345.4 8603.4 8614.7 8627.0 8784.0 516.7 542.9 554.6 572.8 610.6 3975.1 3992.6 4026.6 4028.4 4135.0 93806.5 95650.0 96524.6 96564.0 96626.5 73283.2 80233.0 80900.6 81224.6 81698.6 57844.7 65325.3 65953.0 66119.0 66975.0 7908.2 7926.4 8967.7 9032.3 9203.6 49174.5 49264.8 49448.5 50317.5 50593.7 61680.7 70168.6 72891.3 74573.3 77102.6 10917.9 10957.3 11009.3 11147.5 11450.5 11881.1 12297.2 12342.8 12457.8 12627.9 11163.0 11372.7 11493.9 11677.1 11722.7 11192.3 11719.1 11721.1 11782.1 12280.9 9327.9 11101.8 11232.3 11618.7 11646.5 9121.8 9254.9 9469.1 9591.3 10171.2 8840.9 9115.1 9283.7 9438.8 9884.3 12:53:46 INFO - PROCESS | 1676 | -------- Summary: end -------- 12:53:46 INFO - PROCESS | 1676 | 12:53:46 INFO - TEST-INFO | 1676: exit 0 12:53:46 INFO - TEST-OK | dromaeo_css | took 1113764ms 12:53:46 INFO - TEST-START | kraken 12:53:46 INFO - operating with platform_type : mac_ 12:53:46 INFO - Initialising browser for kraken test... 12:53:46 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpXJMI7W/profile http://localhost:49275/getInfo.html) 12:53:48 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 12:53:48 INFO - PROCESS | 1687 | colorDepth:24 12:53:48 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 12:53:48 INFO - PROCESS | 1687 | __metrics 12:53:48 INFO - PROCESS | 1687 | 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" 12:53:48 INFO - PROCESS | 1687 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:53:49 INFO - TEST-INFO | 1687: exit 0 12:53:49 INFO - Browser initialized. 12:53:49 INFO - Running cycle 1/1 for kraken test... 12:53:49 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpXJMI7W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:01 INFO - PROCESS | 1689 | RSS: Main: 244781056 12:54:01 INFO - PROCESS | 1689 | 12:54:03 INFO - PROCESS | 1689 | 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) 12:54:04 INFO - PROCESS | 1689 | RSS: Main: 290684928 12:54:04 INFO - PROCESS | 1689 | 12:54:07 INFO - PROCESS | 1689 | 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) 12:54:07 INFO - PROCESS | 1689 | RSS: Main: 302166016 12:54:07 INFO - PROCESS | 1689 | 12:54:11 INFO - PROCESS | 1689 | 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) 12:54:11 INFO - PROCESS | 1689 | RSS: Main: 287436800 12:54:11 INFO - PROCESS | 1689 | 12:54:13 INFO - PROCESS | 1689 | 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) 12:54:14 INFO - PROCESS | 1689 | RSS: Main: 288755712 12:54:14 INFO - PROCESS | 1689 | 12:54:16 INFO - PROCESS | 1689 | 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) 12:54:16 INFO - PROCESS | 1689 | RSS: Main: 291037184 12:54:16 INFO - PROCESS | 1689 | 12:54:19 INFO - PROCESS | 1689 | 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) 12:54:20 INFO - PROCESS | 1689 | RSS: Main: 291647488 12:54:20 INFO - PROCESS | 1689 | 12:54:22 INFO - PROCESS | 1689 | 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) 12:54:23 INFO - PROCESS | 1689 | RSS: Main: 291074048 12:54:23 INFO - PROCESS | 1689 | 12:54:26 INFO - PROCESS | 1689 | 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) 12:54:26 INFO - PROCESS | 1689 | RSS: Main: 291479552 12:54:26 INFO - PROCESS | 1689 | 12:54:28 INFO - PROCESS | 1689 | 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) 12:54:29 INFO - PROCESS | 1689 | RSS: Main: 325820416 12:54:29 INFO - PROCESS | 1689 | 12:54:30 INFO - PROCESS | 1689 | 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) 12:54:31 INFO - PROCESS | 1689 | RSS: Main: 324976640 12:54:31 INFO - PROCESS | 1689 | 12:54:33 INFO - PROCESS | 1689 | 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) 12:54:34 INFO - PROCESS | 1689 | RSS: Main: 332509184 12:54:34 INFO - PROCESS | 1689 | 12:54:36 INFO - PROCESS | 1689 | 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) 12:54:37 INFO - PROCESS | 1689 | RSS: Main: 334110720 12:54:37 INFO - PROCESS | 1689 | 12:54:39 INFO - PROCESS | 1689 | 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) 12:54:40 INFO - PROCESS | 1689 | RSS: Main: 334073856 12:54:40 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | 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) 12:54:42 INFO - PROCESS | 1689 | RSS: Main: 393760768 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | __start_tp_report 12:54:42 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 12:54:42 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 12:54:42 INFO - PROCESS | 1689 | |i|pagename|runs| 12:54:42 INFO - PROCESS | 1689 | |0;ai-astar;109;107;106;109;108;110;115;109;109;110 12:54:42 INFO - PROCESS | 1689 | |1;audio-beat-detection;158;121;144;153;135;172;133;122;160;124 12:54:42 INFO - PROCESS | 1689 | |2;audio-dft;183;183;186;185;186;184;184;184;178;182 12:54:42 INFO - PROCESS | 1689 | |3;audio-fft;78;74;84;78;58;57;58;75;76;57 12:54:42 INFO - PROCESS | 1689 | |4;audio-oscillator;95;95;125;78;80;80;112;77;79;109 12:54:42 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;84;88;82;89;91;139;111;90;89;139 12:54:42 INFO - PROCESS | 1689 | |6;imaging-darkroom;93;98;94;93;93;92;93;90;93;110 12:54:42 INFO - PROCESS | 1689 | |7;imaging-desaturate;84;83;87;85;84;86;92;85;69;133 12:54:42 INFO - PROCESS | 1689 | |8;json-parse-financial;56;56;54;53;52;54;53;63;50;54 12:54:42 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;68;65;64;71;68;67;65;66;65;65 12:54:42 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;82;75;79;82;83;82;83;82;84;81 12:54:42 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;128;130;126;131;115;133;125;126;132;123 12:54:42 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;138;126;138;132;136;125;132;138;139;137 12:54:42 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;67;67;66;66;67;69;85;93;95;72 12:54:42 INFO - PROCESS | 1689 | __end_tp_report 12:54:42 INFO - PROCESS | 1689 | __start_cc_report 12:54:42 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,1169 12:54:42 INFO - PROCESS | 1689 | __end_cc_report 12:54:42 INFO - PROCESS | 1689 | __startTimestamp1455569682383__endTimestamp 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | ------- Summary: start ------- 12:54:42 INFO - PROCESS | 1689 | Number of tests: 14 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.00 stddev:2.39 (2.2%) stddev-sans-first:2.54 12:54:42 INFO - PROCESS | 1689 | Values: 109.0 107.0 106.0 109.0 108.0 110.0 115.0 109.0 109.0 110.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:148.50 stddev:17.95 (12.1%) stddev-sans-first:18.10 12:54:42 INFO - PROCESS | 1689 | Values: 158.0 121.0 144.0 153.0 135.0 172.0 133.0 122.0 160.0 124.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:2.32 (1.3%) stddev-sans-first:2.46 12:54:42 INFO - PROCESS | 1689 | Values: 183.0 183.0 186.0 185.0 186.0 184.0 184.0 184.0 178.0 182.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:69.50 Median:75.50 stddev:10.67 (14.1%) stddev-sans-first:10.86 12:54:42 INFO - PROCESS | 1689 | Values: 78.0 74.0 84.0 78.0 58.0 57.0 58.0 75.0 76.0 57.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:79.50 stddev:17.20 (21.6%) stddev-sans-first:18.23 12:54:42 INFO - PROCESS | 1689 | Values: 95.0 95.0 125.0 78.0 80.0 80.0 112.0 77.0 79.0 109.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:100.20 Median:88.50 stddev:21.88 (24.7%) stddev-sans-first:22.41 12:54:42 INFO - PROCESS | 1689 | Values: 84.0 88.0 82.0 89.0 91.0 139.0 111.0 90.0 89.0 139.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:93.00 stddev:5.67 (6.1%) stddev-sans-first:5.97 12:54:42 INFO - PROCESS | 1689 | Values: 93.0 98.0 94.0 93.0 93.0 92.0 93.0 90.0 93.0 110.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:88.80 Median:85.00 stddev:16.59 (19.5%) stddev-sans-first:17.50 12:54:42 INFO - PROCESS | 1689 | Values: 84.0 83.0 87.0 85.0 84.0 86.0 92.0 85.0 69.0 133.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.47 (6.4%) stddev-sans-first:3.64 12:54:42 INFO - PROCESS | 1689 | Values: 56.0 56.0 54.0 53.0 52.0 54.0 53.0 63.0 50.0 54.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:2.12 (3.2%) stddev-sans-first:2.17 12:54:42 INFO - PROCESS | 1689 | Values: 68.0 65.0 64.0 71.0 68.0 67.0 65.0 66.0 65.0 65.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:2.58 (3.2%) stddev-sans-first:2.73 12:54:42 INFO - PROCESS | 1689 | Values: 82.0 75.0 79.0 82.0 83.0 82.0 83.0 82.0 84.0 81.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:129.00 stddev:5.30 (4.1%) stddev-sans-first:5.61 12:54:42 INFO - PROCESS | 1689 | Values: 128.0 130.0 126.0 131.0 115.0 133.0 125.0 126.0 132.0 123.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.10 Median:137.50 stddev:5.15 (3.7%) stddev-sans-first:5.27 12:54:42 INFO - PROCESS | 1689 | Values: 138.0 126.0 138.0 132.0 136.0 125.0 132.0 138.0 139.0 137.0 12:54:42 INFO - PROCESS | 1689 | 12:54:42 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:70.50 stddev:11.65 (16.5%) stddev-sans-first:12.02 12:54:42 INFO - PROCESS | 1689 | Values: 67.0 67.0 66.0 66.0 67.0 69.0 85.0 93.0 95.0 72.0 12:54:42 INFO - PROCESS | 1689 | -------- Summary: end -------- 12:54:42 INFO - PROCESS | 1689 | 12:54:43 INFO - TEST-INFO | 1689: exit 0 12:54:43 INFO - TEST-OK | kraken | took 56243ms 12:54:43 INFO - SUITE-END | took 1170s 12:54:43 INFO - Completed test suite (00:19:30) 12:54:43 INFO - Working with test: dromaeo_css 12:54:43 INFO - Generating results file: dromaeo_css 12:54:43 INFO - Working with test: kraken 12:54:43 INFO - Generating results file: kraken 12:54:43 INFO - javascript benchmark 12:54:43 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:54:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 12:54:43 INFO - process_Request line: dromaeo_css 7514.53 graph.html#tests=[[72,64,59]] 12:54:43 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:54:43 INFO - process_Request line: kraken 1419.20 graph.html#tests=[[232,64,59]] 12:54:43 INFO - RETURN: dromaeo_css: 7514.53 12:54:43 INFO - RETURN: kraken: 1419.20 12:54:43 INFO - javascript benchmark 12:54:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3139.246580820603, 3329.2176338560434, 3448.6378930212327, 3468.462388329809, 3471.5660542432197, 5534.778608855641, 5574.693391863446, 5578.470045345696, 5643.6049476536655, 5655.1517272409155, 5639.407862174464, 5669.09294512878, 5728.398518155585, 5761.251037365137, 5769.942300576993, 5101.489851014906, 5155.072087024343, 5162.92255616166, 5184.403793563751, 5279.208118782175, 5277.366715994086, 5283.471652834724, 5322.121849894782, 5333.2000199969925, 5358.2498450217, 5080.314157588715, 5086.237064440326, 5178.404483484373, 5198.2722418861385, 5230.92153617696, 5159.277701121846, 5188.610854185951, 5199.038177937094, 5202.3497062867145, 5211.03595834768, 5108.310378098983, 5146.0, 5160.638755287131, 5167.689938603658, 5171.4052883918075, 5422.43064478228, 5486.753096110685, 5514.007478653841, 5580.720963951786, 5628.127640215773, 6204.47261982732, 6204.81385558434, 6224.906626400608, 6241.78153764616, 6252.749890004395, 5842.912356314659, 6082.986972859288, 6237.1388284064515, 6265.0915617235705, 6292.4966002719675, 5760.510356619692, 5780.942190578125, 5798.59409841307, 5835.153902684087, 5906.468417842372, 6245.6252624842655, 6252.406021427957, 6257.624542527463, 6277.121203031579, 6281.560290779602, 5376.247325374451, 5667.291588551431, 6129.509639228851, 6132.969335153296, 6134.78528251509, 6166.784162554289, 6240.906386404207, 6246.469050130699, 6262.561620686508, 6271.090691849657, 5159.948400516022, 6154.692265386713, 6192.133101365813, 6197.721102550306, 6201.131841542187, 6075.422834830772, 6163.19878415812, 6177.62934223939, 6223.844403889939, 6238.937610623926, 4146.751194928253, 4808.663393562487, 4820.373351464287, 4853.12643724126, 4874.341963834908, 4328.675349348811, 4424.336349547593, 4442.511323754385, 4459.531749166355, 4461.04087621163, 5478.534324582375, 5537.972310138423, 5544.362398324244, 5549.19536667181, 5576.191452239484, 6225.750969961241, 6228.439440450381, 6241.375862413723, 6242.282137554149, 6247.437730604267, 5474.808381706701, 5573.442655734394, 5585.832425027255, 5637.605367624309, 5687.488126068591, 5348.679079255257, 5348.786048558014, 5366.731663416814, 5369.624126311199, 5370.4629537045985, 6156.230471191101, 6259.96870015647, 6272.874542509216, 6299.590526615755, 6318.273398559132, 6150.138980542638, 6170.382961703794, 6276.403741644536, 6282.120503129657, 6282.937170628235, 6219.253689557101, 6251.249850018027, 6272.717727702356, 6277.968610157102, 6285.685715714105, 5995.970020149872, 6126.417990290915, 6173.444390004921, 6178.073289006685, 6187.752489900534, 6151.32335443092, 6256.906146407899, 6266.216722909637, 6277.372262773686, 6280.968595157177, 5860.472557469848, 6037.0642550404755, 6046.54650901193, 6060.939390606038, 6105.572609917441, 5699.116636921284, 5840.853978650568, 6008.909866351921, 6010.459058684739, 6066.969665151646, 5889.087191485327, 5914.201582786269, 5937.406259374028, 5944.375840536682, 5946.167536544801, 6039.607425517327, 6048.4858787003595, 6081.087836824335, 6086.178365920544, 6122.448979591858, 5751.8562035949435, 5866.882662346815, 5884.882302354014, 5934.19888315072, 6036.064410016279], "unit": "score", "name": "dojo.html", "value": 5648.659348219041}, {"lowerIsBetter": false, "replicates": [455.7151780137414, 462.96989199032157, 491.45694008121023, 558.196197475635, 571.9847271093807, 30635.08094757158, 38812.64155754549, 39443.0, 39480.80259598698, 39481.0, 43620.0, 44114.338284925754, 44170.77914610422, 44224.3366349505, 44385.0, 9714.708558743232, 9944.950275248613, 9955.203583713323, 9956.253281003917, 9963.601455941754, 9849.21206303494, 9988.650397236099, 9995.900040999606, 10001.299909006373, 10006.799864002716, 9956.75108122299, 10018.398896066223, 10020.997900209994, 10030.247731420173, 10037.34757240777, 9904.306698531105, 9984.151347135503, 10005.999400060009, 10018.3488073275, 10018.849717254247, 9734.756631084208, 9892.653757118467, 9897.703068907944, 9903.405795652285, 9904.356216845881, 40394.19211615781, 40727.592724072674, 40840.591594084275, 40869.591304087175, 40939.7953010236, 3162.1936406216496, 3168.936621267585, 3179.332340208559, 3218.082846388768, 3389.864405423805, 28428.28929276764, 29066.5293450057, 29201.561976570367, 29275.8289668413, 29392.706072939425, 2399.7120345558646, 2817.2534278416033, 2858.8856445742144, 2884.4663737208475, 2978.166113488227, 455328.0, 457311.0, 457796.7110164428, 458335.9999999967, 458373.0, 57963.84072318614, 59184.7040764802, 65851.34148658453, 71106.57786844234, 71568.2843171572, 68123.0, 68622.65688671525, 68809.65595171992, 68849.3115068853, 69061.65469172622, 13805.171689698449, 16543.503694889172, 16776.825622206572, 16797.916010420115, 16842.83157168437, 10557.208209384327, 11551.364674942959, 11727.88272117285, 12649.304288264233, 12813.551525696555, 20323.898380508002, 20590.382288531368, 20608.896955515127, 20612.484687882625, 20641.79358206429, 7854.879182620774, 7945.602719863984, 7978.401619878532, 8040.798980025546, 8071.313938315191, 940.2431043010306, 943.4527973775193, 962.3744566031995, 970.8203982263162, 1020.9438480883474, 30162.24594385158, 31346.21634459157, 31622.841885790425, 31763.42713547773, 32332.35335293328, 1051.395447617623, 1081.8972197641212, 1090.8636420447444, 1105.1545567640762, 1155.2490880927464, 13472.730545389037, 13977.161370317814, 14036.43854245839, 14259.643508912153, 14295.428182872776, 423624.0, 427482.0, 427697.0, 427866.0, 429325.0, 54766.72616636891, 54869.72565137149, 55007.72496137574, 55049.1742623861, 55172.448275517534, 1403.7753959366453, 1418.6737050478448, 1431.055503367793, 1435.8061661675958, 1436.3608194353621, 27805.860970695827, 27971.756170240365, 28362.72367743415, 28374.716252837206, 28451.715482844906, 49535.0, 49954.00091998067, 49959.75020124876, 49991.0, 50027.499725002286, 434976.0, 440461.0, 444734.0, 627229.0, 639592.0, 30717.539236911016, 31048.379032419678, 31081.067567972997, 31083.68916310808, 31116.688833112286, 43902.682919511186, 44516.77741611271, 44523.777381112886, 45152.32271515864, 45733.08533829238, 36283.818580906925, 36658.816705917365, 36875.89372318835, 37016.25967480581, 37093.443598345504, 30922.0723378299, 36358.636413635526, 36854.44718329173, 37203.62796372001, 37334.439983400815, 36121.916342509765, 37161.81419092995, 37276.440853387765, 37585.624143758214, 37615.05962350854, 30368.0, 33073.0, 33093.0, 33136.17159570933, 33155.83422082874, 24107.397315067265, 24377.51244975126, 24719.25842224736, 24757.381065473506, 25245.368865778502], "unit": "score", "name": "ext.html", "value": 19628.015445539793}, {"lowerIsBetter": false, "replicates": [365.12734564391104, 366.7689355705905, 368.55773072313224, 370.3999520776343, 373.95325584301963, 15337.539873803777, 15384.233961740221, 18567.628647427042, 19544.706829397554, 20145.899270503665, 19972.50068748282, 20148.798512014877, 20464.07911643976, 21105.366838994854, 21109.261175858846, 3950.4666869972616, 6215.658138802352, 6493.285738568778, 6504.414602685757, 6509.0, 4664.906701865961, 6936.826579335507, 7220.963895180516, 7224.963875180617, 7245.4928155029165, 6802.183737951453, 7167.426605871544, 7168.85662286754, 7178.353948144666, 7179.389751871097, 6788.898166527506, 7026.613536255504, 7049.330313620198, 7056.04743359645, 7069.611171385572, 6650.068990341356, 6723.596584204964, 6742.4268937140405, 6749.797506074826, 6961.547499412522, 26131.869340653364, 26190.0, 26364.077257295903, 26481.470370592673, 26707.599386009224, 2171.4137182960512, 2189.2665956904457, 2215.5314997672663, 2251.8761468119246, 2315.9189428370096, 14587.270636468134, 14736.55790326292, 14987.850121498754, 15191.581894073855, 15616.297266623029, 1551.1313664347888, 1837.80703026183, 1930.0639189992842, 1958.6180694764528, 1963.2147141143514, 75825.86261206087, 89227.99999999935, 90096.0, 90735.0, 92394.5380273101, 10829.67510974672, 11054.778904422028, 11080.412248183717, 11081.335119892832, 11087.0, 13155.73688526224, 13165.868341316656, 13222.735545289233, 13258.73482530344, 13317.200967941955, 6760.391564759097, 8336.541490218096, 8340.499570025819, 8401.15988401155, 8421.621027053798, 6849.828754281183, 8455.196756308142, 8475.618597163018, 8491.957540212383, 8571.571421428904, 4054.4729185205733, 4179.185058913483, 4182.142660754538, 4188.371744238328, 4324.308110702273, 1740.4343588333843, 1784.4468214853177, 3205.919852003672, 3411.8976430707116, 3417.1296111266656, 867.9783005424915, 894.615315414365, 943.3962264150949, 996.8056229035268, 1010.7372083258259, 18176.92069794569, 18689.972051537025, 18756.0, 19773.60452790936, 20234.595308093754, 787.5117427195061, 975.22956864078, 1006.2352612014776, 1018.5518371916334, 1025.4513835098187, 9015.909840901639, 10539.736506587396, 11253.268537545033, 11281.435928203557, 11300.265482743594, 579766.0, 581985.0, 589858.0, 633763.0, 642189.7890510517, 69855.65072174606, 71536.64231678809, 94491.52754236184, 110433.89566104236, 121082.39458802826, 1137.4881303413497, 1158.2992289664633, 1171.4494187731752, 1179.3690375648987, 1181.5982565927625, 17775.91112044483, 17969.0, 18106.378724254937, 18111.547211319823, 18509.81490185081, 31776.364472709953, 38828.41757373585, 48899.02201956012, 49323.0, 51953.15617269269, 71141.64429177821, 71370.0, 71680.0, 71785.6410717943, 72264.63867680628, 7284.235155308616, 7518.473706840468, 7523.1348394935285, 7523.88714169277, 7566.24337566239, 9415.529223538933, 10572.41851698164, 11524.827127592926, 11787.823182652439, 12075.939620301842, 10178.949105254427, 10306.793864122825, 10384.844227336445, 10519.631812886511, 10532.36805791655, 8538.487690738575, 10199.7450063749, 10469.31949423285, 10494.52774625159, 10816.945915270688, 8520.573971301534, 10700.197485188486, 10829.512671929624, 10857.34855908648, 11008.779824403628, 7472.36484898768, 7529.13414957265, 7622.885656715264, 7646.655900484603, 7647.273509016634, 8165.632546535301, 10344.27590068688, 10633.0, 10816.296940698829, 10829.404382759023], "unit": "score", "name": "jquery.html", "value": 9462.395549098064}, {"lowerIsBetter": false, "replicates": [1336.4186578838203, 1390.7427125981687, 1514.7879296898432, 1707.6413953069855, 1906.723525088863, 7855.1752066033105, 8426.325893928486, 8554.0, 8557.871631925518, 8571.214355334525, 8325.625346859391, 8613.698520551781, 8615.612297446614, 8622.525761083138, 8628.309735221183, 2212.8451008429415, 2273.2157405695093, 2485.7017157941073, 2514.8742562871785, 2517.2196619048063, 2477.2692055843568, 2531.392465808202, 2532.025170309435, 2535.2394281715506, 2536.6321883326905, 2391.1869964212165, 2487.4900645367657, 2496.8252222344445, 2497.8751062446804, 2503.0238207099246, 2466.136852101768, 2481.2928315430104, 2501.312139161727, 2501.8498890066653, 2506.147909710689, 2464.0759715106833, 2476.418041760185, 2495.7254701982765, 2507.3480894967256, 2514.4719608882156, 8583.184597463294, 8623.439476434012, 8626.137386261387, 8631.395802293842, 8631.913680863174, 5379.1393377059485, 5508.3114610673665, 5515.338159420895, 5538.501534861882, 5545.140503222007, 3635.1820840310984, 3651.415773476231, 3717.6839968602703, 3738.5700644425965, 3751.3997760358484, 1043.984340234897, 1057.8148823955853, 1060.777236780277, 1090.6019302954444, 1096.199774164864, 11662.59180928672, 11697.0, 11906.404679766063, 11919.582814601446, 11945.984591309749, 4912.557869791736, 4922.990786888679, 4973.502649734997, 5010.448850626428, 5015.3229314042865, 10318.587256509805, 10325.0, 10333.638322658671, 10336.5348559315, 10346.120579750805, 4591.334256532784, 5381.408045115034, 5534.418886016991, 5560.86097847549, 5561.054620714488, 4871.683340582851, 4914.631402644816, 4950.727709975986, 5029.471905449948, 5035.597152227813, 3712.3503386907723, 3759.473673685686, 3762.736608437383, 3770.3967365221433, 3822.1782316802023, 1236.3014896583402, 1314.5859054397833, 1316.3878796359738, 1325.9734805304033, 1333.3533236380347, 1296.9610911672664, 1306.8954483641287, 1308.7447947650307, 1347.5889853594747, 1351.2770667692737, 7885.605719713992, 7946.880796788053, 7992.640331185111, 8001.959745233083, 8006.799830004296, 1174.5595401724354, 1177.988220117805, 1186.649938268213, 1190.458341454636, 1198.8920997110301, 6113.32753397126, 6221.47117495018, 6228.781992630236, 6246.375362463808, 6254.874902501924, 10079.49602519871, 10232.795344093225, 10242.53908574116, 10275.897241027495, 10387.169026478015, 9868.161206297402, 10138.239632027628, 10140.087392134596, 10269.332493387907, 10284.897151028543, 7909.406794490436, 7966.0, 8002.959985200153, 8035.638396272298, 8036.316913062456, 7662.118856331594, 7773.611319434119, 7886.921130788848, 7915.485493442908, 7962.880556791769, 9362.344635875696, 9381.437113773196, 9403.106704863027, 9532.23742100644, 9548.283878709264, 9404.95297523508, 9800.65697700577, 9808.852867206855, 9835.754106147117, 9858.802823943624, 6143.354947730424, 7275.781726548212, 7311.976323314847, 7395.852082958203, 7406.111266648037, 7193.064901562763, 7912.920870791449, 7985.0, 8018.919810801817, 8099.934516698204, 6772.661366931732, 6839.110915580943, 7384.298491643285, 7537.472376933562, 7722.150563437905, 6230.470410015018, 7403.407727381904, 7574.886376704464, 7595.658195381111, 7614.885776713464, 7541.585212813348, 7580.734674286374, 7624.161342252459, 7624.390048796194, 7656.310932016146, 6903.75836845708, 6955.617441040589, 6962.582245065312, 6963.268856770169, 6968.547044442095, 6948.722051117898, 6987.7204911802955, 6998.860022799414, 7004.229534751072, 7130.750423735144], "unit": "score", "name": "mootools.html", "value": 4915.718326104687}, {"lowerIsBetter": false, "replicates": [316.92710676544397, 323.75071195179714, 326.34893387691557, 327.81478464667464, 330.7453260989037, 6592.703328350224, 6595.373439523243, 6602.570832895858, 6623.735050597977, 6633.568818026831, 6486.448651864597, 6567.981962795774, 6578.0, 6587.7035533400995, 6607.273199948002, 4877.268409738541, 4899.461059283476, 4907.312976183337, 4909.3126962225315, 4912.975435122819, 4754.7147171169845, 4895.437024742165, 4898.926516102261, 4923.163062279403, 4941.678790878599, 4110.753354798707, 4629.120467111255, 4821.517848215186, 4829.51704829516, 4838.588719958808, 3845.8653947111716, 4609.400777898885, 4708.176069187878, 4835.2505361669, 4837.105135549917, 4076.5923407659293, 4104.1381309924955, 4134.276501612236, 4138.503379594438, 4140.585941405865, 5105.489451054902, 6324.0, 6339.873202535923, 6348.460380867632, 6349.396807303345, 5407.351117865881, 5508.641938274, 5512.6692398456225, 5571.749271282802, 5733.770649174028, 6791.3548212919695, 6819.795406137824, 7031.542949708252, 7059.611721355323, 7077.787666370017, 3975.185087057146, 4620.422447194101, 4626.629869610423, 4632.795473176964, 4641.883952901205, 7264.164621068592, 7437.776866693954, 7453.136715821045, 7470.514416562906, 7474.626268686544, 4757.0, 4762.78567464465, 4766.022965292176, 4766.737829419415, 4783.928241076386, 3978.8209530571194, 4831.637627177975, 4846.345743324677, 4856.587190088811, 4860.270959356125, 4582.518835522289, 5559.555235581144, 5701.572382071361, 5713.885722285531, 5728.054870946247, 5728.77084916607, 7100.147982242164, 7132.322429369202, 7136.6431678415875, 7138.643067846587, 1652.5290292266645, 1688.6200604863807, 1690.4252554131654, 1691.1713260502265, 1693.102655592538, 1093.4040947683532, 1102.0687519046394, 1108.728361551425, 1116.5757012335423, 1127.8590176227972, 6606.306337834458, 6613.933860661428, 6614.900776488356, 6623.701933413008, 6635.469162466991, 7365.15300740411, 7378.0, 7383.630818459055, 7383.852322953511, 7395.556266624019, 6365.96817015912, 6599.175103112111, 6608.933910660832, 6608.966955165193, 6611.603303801788, 3870.4774855394726, 3914.8434062637175, 3917.4515567820526, 3921.862734804325, 3927.19492504036, 7620.0, 7659.387249020065, 7670.0795904491815, 7675.385969122457, 7685.346745526581, 6126.172966649535, 7137.607431591208, 7167.569945803269, 7573.697052117854, 7627.0, 7533.623318834037, 7644.6942122315595, 7653.043369578802, 7655.961720191363, 7682.423818213544, 7416.221296763762, 7461.813454663677, 7463.888041679488, 7478.962605186939, 7482.176960534446, 7047.189573199148, 7207.927920720936, 7226.783196504113, 7231.8553628928175, 7314.926850731425, 6249.25008998923, 7636.923630763621, 7644.961775191088, 7709.267619576131, 7756.108047574601, 3979.8060581825916, 4587.449506059294, 4597.42532183477, 4674.182018146878, 4685.250359942393, 7118.181409138016, 7299.087614048244, 7385.889211661937, 7409.184989651027, 7410.4442166836625, 7144.499885007999, 7145.1068616422945, 7151.32062454066, 7152.177499587614, 7169.5698258104685, 6953.79138625842, 7097.148342198969, 7124.862541237711, 7133.464990125865, 7155.212926577969, 6914.654267286716, 6962.443004559725, 6964.860702786017, 6970.337817907291, 6977.232504424611, 5785.768569257182, 7130.073090498202, 7133.750318738819, 7149.392301654418, 7149.964250178716, 6784.118064651564, 7001.824954376181, 7009.228984811564, 7019.508634395544, 7024.5082844200415], "unit": "score", "name": "prototype.html", "value": 5148.93503568774}, {"lowerIsBetter": false, "replicates": [684.7021545627653, 716.5987047253535, 741.2143128284017, 751.0, 780.6213986216684, 14913.478028269014, 15120.941534092617, 15124.243787810621, 15125.319360628771, 15137.24313784312, 11868.109891758131, 12397.628071157857, 12424.130310878241, 12724.872751272485, 12733.681657958556, 846.3863698818369, 865.5109862927458, 866.7183165471215, 866.7443104284251, 868.9044205137461, 851.1360968616827, 862.5859587398053, 866.8223014282057, 867.4188293843109, 868.4658934755143, 889.8220355928808, 905.1355955062932, 907.4509921497498, 907.7231444409452, 911.0934620053057, 887.6626881784913, 898.7258886039755, 900.7612982559627, 902.6073657958743, 902.9638814447414, 662.2086606505228, 667.0494545272967, 672.8923372260415, 674.6053558668185, 674.912261406019, 12821.102522823407, 12871.613851584467, 12876.484940602364, 12900.935495322557, 12979.805302920464, 11312.09503239747, 11363.602273920373, 11419.828702569468, 11456.828147577793, 11833.822492662617, 9564.952175239148, 9591.184749296319, 9632.951835240849, 9683.0, 9763.853542196874, 3445.4831775233665, 3458.4466485362223, 3467.687908088284, 3482.669146431085, 3593.245418462126, 62799.6860015697, 76886.0, 79445.60277198577, 80567.0, 80732.59633701852, 7585.658645360972, 8125.431219814556, 9394.671186508576, 9481.573329200202, 9560.808783824285, 19935.700964485546, 20125.09437075335, 20145.899270503847, 20211.393658190278, 20244.0, 7438.256174382518, 7479.962600186965, 7560.810979725551, 7666.080070391588, 7807.726729564438, 4085.264652362603, 4098.774567398762, 4108.36320370343, 4126.339785634284, 4139.8965025874595, 3509.7543171978227, 3567.35787558242, 3569.089882080053, 3569.5181150544863, 3573.6962358199326, 637.6907200007993, 645.2901808011244, 648.503894520692, 669.581511555278, 671.3051991189096, 475.4508542633264, 562.4825160852026, 594.2393736017904, 638.4477427025682, 647.252423450915, 8345.374096942633, 8603.440776349516, 8614.698485552975, 8627.0, 8783.956080219687, 516.6564234783901, 542.9371114358622, 554.5923746046652, 572.7766171193238, 610.6122612141234, 3975.1254723960683, 3992.6007399259843, 4026.5570787213383, 4028.436018957348, 4135.048938744106, 93806.53096734473, 95650.0, 96524.55213171808, 96564.0, 96626.51686741521, 73283.1679208024, 80233.0, 80900.59549702214, 81224.59387703142, 81698.59150704209, 57844.71077644585, 65325.34674653288, 65953.0, 66119.00821487681, 66975.0, 7908.248716371935, 7926.445148839526, 8967.686130985385, 9032.277417806428, 9203.631854725736, 49174.50825491699, 49264.75367623139, 49448.50551494439, 50317.49682503128, 50593.73515662138, 61680.69159654173, 70168.64915675389, 72891.27108728845, 74573.2542674588, 77102.61448692721, 10917.945410272898, 10957.342559446459, 11009.284396514522, 11147.498362573542, 11450.484728187084, 11881.1089168311, 12297.200681955645, 12342.81485777696, 12457.750844983231, 12627.873721263037, 11163.0, 11372.715682108013, 11493.942530287295, 11677.06583473337, 11722.70693232676, 11192.272502287326, 11719.062475001809, 11721.06231501495, 11782.057435405319, 12280.938595306967, 9327.906720932704, 11101.833472498081, 11232.3260604364, 11618.6514404568, 11646.475908583965, 9121.77195570116, 9254.861177082485, 9469.10043545862, 9591.28065395112, 10171.23715721309, 8840.911590884009, 9115.134062264075, 9283.72148835509, 9438.811223775623, 9884.25868059884], "unit": "score", "name": "yui.html", "value": 6780.289119830876}], "name": "dromaeo_css", "value": 7514.528373383946}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 106.0, 109.0, 108.0, 110.0, 115.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [158.0, 121.0, 144.0, 153.0, 135.0, 172.0, 133.0, 122.0, 160.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 186.0, 185.0, 186.0, 184.0, 184.0, 184.0, 178.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [78.0, 74.0, 84.0, 78.0, 58.0, 57.0, 58.0, 75.0, 76.0, 57.0], "unit": "score", "name": "audio-fft", "value": 69.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 125.0, 78.0, 80.0, 80.0, 112.0, 77.0, 79.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 82.0, 89.0, 91.0, 139.0, 111.0, 90.0, 89.0, 139.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.2}, {"lowerIsBetter": true, "replicates": [93.0, 98.0, 94.0, 93.0, 93.0, 92.0, 93.0, 90.0, 93.0, 110.0], "unit": "score", "name": "imaging-darkroom", "value": 94.9}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 87.0, 85.0, 84.0, 86.0, 92.0, 85.0, 69.0, 133.0], "unit": "score", "name": "imaging-desaturate", "value": 88.8}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 54.0, 53.0, 52.0, 54.0, 53.0, 63.0, 50.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 64.0, 71.0, 68.0, 67.0, 65.0, 66.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [82.0, 75.0, 79.0, 82.0, 83.0, 82.0, 83.0, 82.0, 84.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [128.0, 130.0, 126.0, 131.0, 115.0, 133.0, 125.0, 126.0, 132.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 138.0, 132.0, 136.0, 125.0, 132.0, 138.0, 139.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 67.0, 69.0, 85.0, 93.0, 95.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.7}], "name": "kraken", "value": 1419.2}]} 12:54:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1419.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7514.53"}}} 12:54:44 INFO - Return code: 0 12:54:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:54:44 INFO - # TBPL SUCCESS # 12:54:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:54:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:54:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:54:44 INFO - 2016-02-15 12:54:44.098 screenresolution[1693:9737] starting screenresolution argv=screenresolution get 12:54:44 INFO - 2016-02-15 12:54:44.100 screenresolution[1693:9737] Display 0: 1600x1200x32@60 12:54:44 INFO - 2016-02-15 12:54:44.106 screenresolution[1694:9740] starting screenresolution argv=screenresolution list 12:54:44 INFO - Available Modes on Display 0 12:54:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:54:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:54:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:54:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:54:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:54:44 INFO - Intel Iris: 12:54:44 INFO - Chipset Model: Intel Iris 12:54:44 INFO - Type: GPU 12:54:44 INFO - Bus: Built-In 12:54:44 INFO - VRAM (Dynamic, Max): 1536 MB 12:54:44 INFO - Vendor: Intel (0x8086) 12:54:44 INFO - Device ID: 0x0a2e 12:54:44 INFO - Revision ID: 0x0009 12:54:44 INFO - Displays: 12:54:44 INFO - Display: 12:54:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:54:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:54:44 INFO - Display Serial Number: 1600x1200 60 12:54:44 INFO - Main Display: Yes 12:54:44 INFO - Mirror: Off 12:54:44 INFO - Online: Yes 12:54:44 INFO - Rotation: Supported 12:54:44 INFO - Return code: 0 12:54:44 INFO - Running post-action listener: _resource_record_post_action 12:54:44 INFO - Running post-run listener: _resource_record_post_run 12:54:45 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39532032; Write bytes: 711618560; Read time: 426; Write time: 2045 12:54:45 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404742656; Write bytes: 405562880; Read time: 30209; Write time: 723 12:54:45 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 37697024; Write bytes: 300835328; Read time: 405; Write time: 1237 12:54:45 INFO - Running post-run listener: _upload_blobber_files 12:54:45 INFO - Blob upload gear active. 12:54:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:54:45 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 12:54:45 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'] 12:54:45 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 12:54:45 INFO - (blobuploader) - INFO - Open directory for files ... 12:54:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:54:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:54:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:47 INFO - (blobuploader) - INFO - Done attempting. 12:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:48 INFO - (blobuploader) - INFO - Done attempting. 12:54:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:54:48 INFO - Return code: 0 12:54:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:54:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:54:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d34611594a7c643572adb739ae28608310df6ccafc1b1428c9abd0ba31e8d5f523f1248114892009dd465dd1a26cfcaa22fcdfc20508693802a3faccb7151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c8bfffdf73fcfd13046ff91ed79814f853658d27e7f31fc0b718df40c5f12ebfb17cad9e112030b43f340bd047a8c00685cfd845605a8e4e1b22d88c9f5b70a"} 12:54:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:54:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:54:48 INFO - Contents: 12:54:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d34611594a7c643572adb739ae28608310df6ccafc1b1428c9abd0ba31e8d5f523f1248114892009dd465dd1a26cfcaa22fcdfc20508693802a3faccb7151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c8bfffdf73fcfd13046ff91ed79814f853658d27e7f31fc0b718df40c5f12ebfb17cad9e112030b43f340bd047a8c00685cfd845605a8e4e1b22d88c9f5b70a"} 12:54:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:54:48 INFO - Copying logs to upload dir... 12:54:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:54:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.751622 ========= master_lag: 2.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-15 12:54:50.870248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 12:54:50.875726) ========= 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.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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/258d34611594a7c643572adb739ae28608310df6ccafc1b1428c9abd0ba31e8d5f523f1248114892009dd465dd1a26cfcaa22fcdfc20508693802a3faccb7151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c8bfffdf73fcfd13046ff91ed79814f853658d27e7f31fc0b718df40c5f12ebfb17cad9e112030b43f340bd047a8c00685cfd845605a8e4e1b22d88c9f5b70a"} build_url:https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010928 build_url: 'https://queue.taskcluster.net/v1/task/L79rns2cQOS4R__HFQhVAw/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/258d34611594a7c643572adb739ae28608310df6ccafc1b1428c9abd0ba31e8d5f523f1248114892009dd465dd1a26cfcaa22fcdfc20508693802a3faccb7151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c8bfffdf73fcfd13046ff91ed79814f853658d27e7f31fc0b718df40c5f12ebfb17cad9e112030b43f340bd047a8c00685cfd845605a8e4e1b22d88c9f5b70a"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 12:54:50.927078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 12:54:50.927403) ========= 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.cIHxIYufjW/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.LlXzcyzs2y/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005096 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 12:54:50.991196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 12:54:50.991549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 12:54:51.000158) ========= ========= Total master_lag: 2.96 =========