builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0029 starttime: 1455139012.69 results: success (0) buildid: 20160210093439 builduid: dafa863f67f547eaa24e0203fdbeffee revision: 15af46c34a81788cf616367148f00e3d0950122a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:52.691539) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:52.692382) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:52.692693) ========= 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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005747 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:52.757942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:52.758212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:52.924993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:52.925645) ========= 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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005150 ========= master_lag: 0.96 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:53.888408) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:53.888715) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:53.889068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:53.889338) ========= 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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-10 13:16:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 35.6M=0s 2016-02-10 13:16:54 (35.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.649696 ========= master_lag: 0.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:54.877910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:54.878194) ========= 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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019589 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:55.141683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 13:16:55.144500) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 15af46c34a81788cf616367148f00e3d0950122a --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 15af46c34a81788cf616367148f00e3d0950122a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-10 13:16:55,258 truncating revision to first 12 chars 2016-02-10 13:16:55,258 Setting DEBUG logging. 2016-02-10 13:16:55,258 attempt 1/10 2016-02-10 13:16:55,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/15af46c34a81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 13:16:55,566 unpacking tar archive at: fx-team-15af46c34a81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554551 ========= master_lag: 0.93 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 13:16:56.628505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:56.628832) ========= echo 15af46c34a81788cf616367148f00e3d0950122a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'15af46c34a81788cf616367148f00e3d0950122a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15af46c34a81788cf616367148f00e3d0950122a program finished with exit code 0 elapsedTime=0.004939 script_repo_revision: '15af46c34a81788cf616367148f00e3d0950122a' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:56.718569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:56.718895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 13:16:57.293928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-02-10 13:16:57.298469) ========= /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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:16:57 INFO - MultiFileLogger online at 20160210 13:16:57 in /builds/slave/test 13:16:57 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 13:16:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:16:57 INFO - {'append_to_log': False, 13:16:57 INFO - 'base_work_dir': '/builds/slave/test', 13:16:57 INFO - 'blob_upload_branch': 'Fx-Team', 13:16:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:16:57 INFO - 'branch': 'Fx-Team', 13:16:57 INFO - 'buildbot_json_path': 'buildprops.json', 13:16:57 INFO - 'config_files': ('talos/mac_config.py',), 13:16:57 INFO - 'default_actions': ('clobber', 13:16:57 INFO - 'read-buildbot-config', 13:16:57 INFO - 'download-and-extract', 13:16:57 INFO - 'populate-webroot', 13:16:57 INFO - 'create-virtualenv', 13:16:57 INFO - 'install', 13:16:57 INFO - 'run-tests'), 13:16:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:16:57 INFO - 'download_minidump_stackwalk': True, 13:16:57 INFO - 'download_symbols': 'ondemand', 13:16:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:16:57 INFO - 'tooltool.py': '/tools/tooltool.py', 13:16:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:16:57 INFO - '/tools/misc-python/virtualenv.py')}, 13:16:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:16:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:16:57 INFO - 'installer_path': 'installer.exe', 13:16:57 INFO - 'log_level': 'info', 13:16:57 INFO - 'log_name': 'talos', 13:16:57 INFO - 'log_to_console': True, 13:16:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:16:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:16:57 INFO - 'opt_config_files': (), 13:16:57 INFO - 'pip_index': False, 13:16:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:16:57 INFO - 'cmd': ('bash', 13:16:57 INFO - '-c', 13:16:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:16:57 INFO - 'enabled': True, 13:16:57 INFO - 'halt_on_failure': False, 13:16:57 INFO - 'name': 'check_screen_resolution'},), 13:16:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:16:57 INFO - 'cmd': ('bash', 13:16:57 INFO - '-c', 13:16:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:16:57 INFO - 'enabled': True, 13:16:57 INFO - 'halt_on_failure': False, 13:16:57 INFO - 'name': 'check_screen_resolution'},), 13:16:57 INFO - 'run_cmd_checks_enabled': True, 13:16:57 INFO - 'sps_profile': False, 13:16:57 INFO - 'sps_profile_interval': 0, 13:16:57 INFO - 'suite': 'dromaeojs', 13:16:57 INFO - 'system_bits': '32', 13:16:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:16:57 INFO - 'title': 't-yosemite-r7-0029', 13:16:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:16:57 INFO - 'use_talos_json': True, 13:16:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:16:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:16:57 INFO - 'work_dir': 'build'} 13:16:57 INFO - ##### 13:16:57 INFO - ##### Running clobber step. 13:16:57 INFO - ##### 13:16:57 INFO - Running pre-action listener: _resource_record_pre_action 13:16:57 INFO - Running main action method: clobber 13:16:57 INFO - rmtree: /builds/slave/test/build 13:16:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:16:58 INFO - Running post-action listener: _resource_record_post_action 13:16:58 INFO - ##### 13:16:58 INFO - ##### Running read-buildbot-config step. 13:16:58 INFO - ##### 13:16:58 INFO - Running pre-action listener: _resource_record_pre_action 13:16:58 INFO - Running main action method: read_buildbot_config 13:16:58 INFO - Using buildbot properties: 13:16:58 INFO - { 13:16:58 INFO - "project": "", 13:16:58 INFO - "product": "firefox", 13:16:58 INFO - "script_repo_revision": "production", 13:16:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:16:58 INFO - "repository": "", 13:16:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:16:58 INFO - "buildid": "20160210093439", 13:16:58 INFO - "pgo_build": "False", 13:16:58 INFO - "basedir": "/builds/slave/test", 13:16:58 INFO - "buildnumber": 321, 13:16:58 INFO - "slavename": "t-yosemite-r7-0029", 13:16:58 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:16:58 INFO - "platform": "yosemite_r7", 13:16:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:16:58 INFO - "branch": "fx-team", 13:16:58 INFO - "repo_path": "integration/fx-team", 13:16:58 INFO - "revision": "15af46c34a81788cf616367148f00e3d0950122a", 13:16:58 INFO - "stage_platform": "macosx64", 13:16:58 INFO - "builduid": "dafa863f67f547eaa24e0203fdbeffee", 13:16:58 INFO - "slavebuilddir": "test" 13:16:58 INFO - } 13:16:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 13:16:58 INFO - Running post-action listener: _resource_record_post_action 13:16:58 INFO - ##### 13:16:58 INFO - ##### Running download-and-extract step. 13:16:58 INFO - ##### 13:16:58 INFO - Running pre-action listener: _resource_record_pre_action 13:16:58 INFO - Running main action method: download_and_extract 13:16:58 INFO - mkdir: /builds/slave/test/build/tests 13:16: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')]} 13:16:58 INFO - https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/test_packages.json 13:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/test_packages.json 13:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:17:04 INFO - Downloaded 1277 bytes. 13:17:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:17:04 INFO - Using the following test package requirements: 13:17:04 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:17:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:17:04 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 13:17:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:17:04 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 13:17:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:17:04 INFO - u'jsshell-mac.zip'], 13:17:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:17:04 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 13:17:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:17:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:17:04 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 13:17:04 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:17:04 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 13:17:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:17:04 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 13:17:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:17:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:17:04 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 13:17:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:04 INFO - https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/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 13:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/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 13:17:07 INFO - Downloaded 17750509 bytes. 13:17:07 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'] 13:17:07 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 13:17:10 INFO - Return code: 0 13:17:10 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 13:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:10 INFO - https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:17:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:17:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:17:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/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 13:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/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 13:17:12 INFO - Downloaded 17750509 bytes. 13:17:12 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'] 13:17:12 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 13:17:16 INFO - Return code: 0 13:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:16 INFO - https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/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 13:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/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 13:17:19 INFO - Downloaded 10706547 bytes. 13:17:19 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'] 13:17:19 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 13:17:20 INFO - Return code: 0 13:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:20 INFO - https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 13:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WiOriGWPSpuTaeIxuopY-w/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 13:17:26 INFO - Downloaded 111185044 bytes. 13:17:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:17:26 INFO - mkdir: /builds/slave/test/properties 13:17:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:26 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:26 INFO - Contents: 13:17:26 INFO - build_url:https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:17:27 INFO - Running post-action listener: _resource_record_post_action 13:17:27 INFO - Running post-action listener: set_extra_try_arguments 13:17:27 INFO - ##### 13:17:27 INFO - ##### Running populate-webroot step. 13:17:27 INFO - ##### 13:17:27 INFO - Running pre-action listener: _resource_record_pre_action 13:17:27 INFO - Running main action method: populate_webroot 13:17:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:27 INFO - '--tppagecycles', 13:17:27 INFO - '7'], 13:17:27 INFO - 'tests': ['tsvgm']}}, 13:17:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:17:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:17:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:27 INFO - 'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:27 INFO - 'tests': ['damp', 'tps']}, 13:17:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:27 INFO - 'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['damp', 'tps']}, 13:17:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:17:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:27 INFO - 'other': {'tests': ['a11yr', 13:17:27 INFO - 'ts_paint', 13:17:27 INFO - 'tpaint', 13:17:27 INFO - 'sessionrestore', 13:17:27 INFO - 'sessionrestore_no_auto_restore']}, 13:17:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['a11yr', 13:17:27 INFO - 'ts_paint', 13:17:27 INFO - 'tpaint', 13:17:27 INFO - 'sessionrestore', 13:17:27 INFO - 'sessionrestore_no_auto_restore']}, 13:17:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['a11yr', 13:17:27 INFO - 'ts_paint', 13:17:27 INFO - 'tpaint', 13:17:27 INFO - 'sessionrestore', 13:17:27 INFO - 'sessionrestore_no_auto_restore']}, 13:17:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['a11yr', 13:17:27 INFO - 'ts_paint', 13:17:27 INFO - 'tpaint', 13:17:27 INFO - 'sessionrestore', 13:17:27 INFO - 'sessionrestore_no_auto_restore']}, 13:17:27 INFO - 'other_l64': {'tests': ['a11yr', 13:17:27 INFO - 'ts_paint', 13:17:27 INFO - 'tpaint', 13:17:27 INFO - 'sessionrestore', 13:17:27 INFO - 'sessionrestore_no_auto_restore']}, 13:17:27 INFO - 'other_nol64': {'tests': ['a11yr', 13:17:27 INFO - 'ts_paint', 13:17:27 INFO - 'tpaint', 13:17:27 INFO - 'sessionrestore', 13:17:27 INFO - 'sessionrestore_no_auto_restore']}, 13:17:27 INFO - 'svgr': {'tests': ['tsvgx', 13:17:27 INFO - 'tsvgr_opacity', 13:17:27 INFO - 'tart', 13:17:27 INFO - 'tscrollx', 13:17:27 INFO - 'cart']}, 13:17:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['tsvgx', 13:17:27 INFO - 'tsvgr_opacity', 13:17:27 INFO - 'tart', 13:17:27 INFO - 'tscrollx', 13:17:27 INFO - 'cart']}, 13:17:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:27 INFO - 'tests': ['tp5o']}, 13:17:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:27 INFO - 'talos_options': ['--e10s'], 13:17:27 INFO - 'tests': ['tp5o']}, 13:17:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:27 INFO - 'talos_options': ['--xperf_path', 13:17:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:27 INFO - 'tests': ['tp5n']}, 13:17:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:27 INFO - 'talos_options': ['--e10s', 13:17:27 INFO - '--xperf_path', 13:17:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:27 INFO - 'tests': ['tp5n']}}, 13:17:27 INFO - 'talos.zip': {'path': '', 13:17:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:27 INFO - Running post-action listener: _resource_record_post_action 13:17:27 INFO - ##### 13:17:27 INFO - ##### Running create-virtualenv step. 13:17:27 INFO - ##### 13:17:27 INFO - Running pre-action listener: _resource_record_pre_action 13:17:27 INFO - Running main action method: create_virtualenv 13:17:27 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:27 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 13:17:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:27 INFO - Using real prefix '/tools/python27' 13:17:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:28 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:31 INFO - Installing pip.................done. 13:17:31 INFO - Return code: 0 13:17:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:31 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')]} 13:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 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')]} 13:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:31 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 13:17:31 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 13:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:31 INFO - 'HOME': '/Users/cltbld', 13:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:31 INFO - 'LOGNAME': 'cltbld', 13:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:31 INFO - 'MOZ_NO_REMOTE': '1', 13:17:31 INFO - 'NO_EM_RESTART': '1', 13:17:31 INFO - 'PAGER': '/bin/cat', 13:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:31 INFO - 'PWD': '/builds/slave/test', 13:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:31 INFO - 'SHELL': '/bin/bash', 13:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:31 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:31 INFO - 'USER': 'cltbld', 13:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:31 INFO - 'XPC_FLAGS': '0x0', 13:17:31 INFO - 'XPC_SERVICE_NAME': '0', 13:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:31 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 13:17:31 INFO - Cleaning up... 13:17:31 INFO - Return code: 0 13:17:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:17:31 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')]} 13:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 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')]} 13:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:31 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 13:17:31 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 13:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:31 INFO - 'HOME': '/Users/cltbld', 13:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:31 INFO - 'LOGNAME': 'cltbld', 13:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:31 INFO - 'MOZ_NO_REMOTE': '1', 13:17:31 INFO - 'NO_EM_RESTART': '1', 13:17:31 INFO - 'PAGER': '/bin/cat', 13:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:31 INFO - 'PWD': '/builds/slave/test', 13:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:31 INFO - 'SHELL': '/bin/bash', 13:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:31 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:31 INFO - 'USER': 'cltbld', 13:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:31 INFO - 'XPC_FLAGS': '0x0', 13:17:31 INFO - 'XPC_SERVICE_NAME': '0', 13:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:31 INFO - Downloading/unpacking psutil>=0.7.1 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:34 INFO - Installing collected packages: psutil 13:17:34 INFO - Running setup.py install for psutil 13:17:34 INFO - building 'psutil._psutil_osx' extension 13:17:34 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 13:17:35 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 13:17:35 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 13:17:35 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 13:17:35 INFO - building 'psutil._psutil_posix' extension 13:17:35 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 13:17:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:17:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:17:35 INFO - ^ 13:17:35 INFO - 1 warning generated. 13:17:35 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 13:17:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:35 INFO - Successfully installed psutil 13:17:35 INFO - Cleaning up... 13:17:35 INFO - Return code: 0 13:17:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:35 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 13:17:35 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 13:17:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:35 INFO - 'HOME': '/Users/cltbld', 13:17:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:35 INFO - 'LOGNAME': 'cltbld', 13:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:35 INFO - 'MOZ_NO_REMOTE': '1', 13:17:35 INFO - 'NO_EM_RESTART': '1', 13:17:35 INFO - 'PAGER': '/bin/cat', 13:17:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:35 INFO - 'PWD': '/builds/slave/test', 13:17:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:35 INFO - 'SHELL': '/bin/bash', 13:17:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:35 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:35 INFO - 'USER': 'cltbld', 13:17:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:35 INFO - 'XPC_FLAGS': '0x0', 13:17:35 INFO - 'XPC_SERVICE_NAME': '0', 13:17:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:17:38 INFO - Installing collected packages: mozsystemmonitor 13:17:38 INFO - Running setup.py install for mozsystemmonitor 13:17:38 INFO - Successfully installed mozsystemmonitor 13:17:38 INFO - Cleaning up... 13:17:38 INFO - Return code: 0 13:17:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:38 INFO - 'HOME': '/Users/cltbld', 13:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:38 INFO - 'LOGNAME': 'cltbld', 13:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:38 INFO - 'MOZ_NO_REMOTE': '1', 13:17:38 INFO - 'NO_EM_RESTART': '1', 13:17:38 INFO - 'PAGER': '/bin/cat', 13:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:38 INFO - 'PWD': '/builds/slave/test', 13:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:38 INFO - 'SHELL': '/bin/bash', 13:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:38 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:38 INFO - 'USER': 'cltbld', 13:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:38 INFO - 'XPC_FLAGS': '0x0', 13:17:38 INFO - 'XPC_SERVICE_NAME': '0', 13:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:38 INFO - Downloading/unpacking blobuploader==1.2.4 13:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:41 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:42 INFO - Downloading docopt-0.6.1.tar.gz 13:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:42 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:42 INFO - Running setup.py install for blobuploader 13:17:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:42 INFO - Running setup.py install for requests 13:17:42 INFO - Running setup.py install for docopt 13:17:43 INFO - Successfully installed blobuploader requests docopt 13:17:43 INFO - Cleaning up... 13:17:43 INFO - Return code: 0 13:17:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:43 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')]} 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 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')]} 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:43 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 13:17:43 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 13:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:43 INFO - 'HOME': '/Users/cltbld', 13:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:43 INFO - 'LOGNAME': 'cltbld', 13:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:43 INFO - 'MOZ_NO_REMOTE': '1', 13:17:43 INFO - 'NO_EM_RESTART': '1', 13:17:43 INFO - 'PAGER': '/bin/cat', 13:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:43 INFO - 'PWD': '/builds/slave/test', 13:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:43 INFO - 'SHELL': '/bin/bash', 13:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:43 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:43 INFO - 'USER': 'cltbld', 13:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:43 INFO - 'XPC_FLAGS': '0x0', 13:17:43 INFO - 'XPC_SERVICE_NAME': '0', 13:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dL8WcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-s2EkhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-PenGZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Der1uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-0DurAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-L6PCH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-MYY14_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hnkGfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ZrjklG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-P89Ufe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-CQvquK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-P97YUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-I2x55q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-JB97QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:44 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-evdR7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:45 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-0eUDVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:45 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-rjlVYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:45 INFO - Running setup.py install for manifestparser 13:17:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:45 INFO - Running setup.py install for mozcrash 13:17:45 INFO - Running setup.py install for mozdebug 13:17:45 INFO - Running setup.py install for mozdevice 13:17:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:45 INFO - Running setup.py install for mozfile 13:17:46 INFO - Running setup.py install for mozhttpd 13:17:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozinfo 13:17:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozInstall 13:17:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozleak 13:17:46 INFO - Running setup.py install for mozlog 13:17:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for moznetwork 13:17:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:46 INFO - Running setup.py install for mozprocess 13:17:47 INFO - Running setup.py install for mozprofile 13:17:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Running setup.py install for mozrunner 13:17:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Running setup.py install for mozscreenshot 13:17:47 INFO - Running setup.py install for moztest 13:17:47 INFO - Running setup.py install for mozversion 13:17:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:47 INFO - Cleaning up... 13:17:47 INFO - Return code: 0 13:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:47 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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:47 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 13:17:47 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 13:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:47 INFO - 'HOME': '/Users/cltbld', 13:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:47 INFO - 'LOGNAME': 'cltbld', 13:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:47 INFO - 'MOZ_NO_REMOTE': '1', 13:17:47 INFO - 'NO_EM_RESTART': '1', 13:17:47 INFO - 'PAGER': '/bin/cat', 13:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:47 INFO - 'PWD': '/builds/slave/test', 13:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:47 INFO - 'SHELL': '/bin/bash', 13:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:47 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:47 INFO - 'USER': 'cltbld', 13:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:47 INFO - 'XPC_FLAGS': '0x0', 13:17:47 INFO - 'XPC_SERVICE_NAME': '0', 13:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Vbp8mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-1Mb7VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-1az0p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-A9fTuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-yCgGom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jEubNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-zzZAgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:48 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-YzI_Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:48 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)) 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-P3jkDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Z35xw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-P6eCfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-20W8xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-x4He0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-yz592w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-k0webI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-P3W2wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:49 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)) 13:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:49 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-He4brA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:49 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)) 13:17:49 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)) 13:17:49 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)) 13:17:49 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)) 13:17:49 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)) 13:17:49 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)) 13:17:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:49 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 13:17:49 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 13:17:49 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 13:17:49 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 13:17:49 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 13:17:49 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 13:17:52 INFO - Downloading blessings-1.6.tar.gz 13:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:52 INFO - Installing collected packages: blessings 13:17:52 INFO - Running setup.py install for blessings 13:17:52 INFO - Successfully installed blessings 13:17:52 INFO - Cleaning up... 13:17:52 INFO - Return code: 0 13:17:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:52 INFO - Reading from file tmpfile_stdout 13:17:52 INFO - Current package versions: 13:17:52 INFO - blessings == 1.6 13:17:52 INFO - blobuploader == 1.2.4 13:17:52 INFO - docopt == 0.6.1 13:17:52 INFO - manifestparser == 1.1 13:17:52 INFO - mozInstall == 1.12 13:17:52 INFO - mozcrash == 0.16 13:17:52 INFO - mozdebug == 0.1 13:17:52 INFO - mozdevice == 0.48 13:17:52 INFO - mozfile == 1.2 13:17:52 INFO - mozhttpd == 0.7 13:17:52 INFO - mozinfo == 0.9 13:17:52 INFO - mozleak == 0.1 13:17:52 INFO - mozlog == 3.1 13:17:52 INFO - moznetwork == 0.27 13:17:52 INFO - mozprocess == 0.22 13:17:52 INFO - mozprofile == 0.28 13:17:52 INFO - mozrunner == 6.11 13:17:52 INFO - mozscreenshot == 0.1 13:17:52 INFO - mozsystemmonitor == 0.0 13:17:52 INFO - moztest == 0.7 13:17:52 INFO - mozversion == 1.4 13:17:52 INFO - psutil == 3.1.1 13:17:52 INFO - requests == 1.2.3 13:17:52 INFO - wsgiref == 0.1.2 13:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:52 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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:52 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 13:17:52 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 13:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:52 INFO - 'HOME': '/Users/cltbld', 13:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:52 INFO - 'LOGNAME': 'cltbld', 13:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:52 INFO - 'MOZ_NO_REMOTE': '1', 13:17:52 INFO - 'NO_EM_RESTART': '1', 13:17:52 INFO - 'PAGER': '/bin/cat', 13:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:52 INFO - 'PWD': '/builds/slave/test', 13:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:52 INFO - 'SHELL': '/bin/bash', 13:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:52 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:52 INFO - 'USER': 'cltbld', 13:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:52 INFO - 'XPC_FLAGS': '0x0', 13:17:52 INFO - 'XPC_SERVICE_NAME': '0', 13:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 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)) 13:17:53 INFO - Cleaning up... 13:17:53 INFO - Return code: 0 13:17:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:53 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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:53 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 13:17:53 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 13:17:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:53 INFO - 'HOME': '/Users/cltbld', 13:17:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:53 INFO - 'LOGNAME': 'cltbld', 13:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:53 INFO - 'MOZ_NO_REMOTE': '1', 13:17:53 INFO - 'NO_EM_RESTART': '1', 13:17:53 INFO - 'PAGER': '/bin/cat', 13:17:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:53 INFO - 'PWD': '/builds/slave/test', 13:17:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:53 INFO - 'SHELL': '/bin/bash', 13:17:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:53 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:53 INFO - 'USER': 'cltbld', 13:17:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:53 INFO - 'XPC_FLAGS': '0x0', 13:17:53 INFO - 'XPC_SERVICE_NAME': '0', 13:17:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:53 INFO - Downloading/unpacking jsonschema 13:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:55 INFO - Downloading/unpacking functools32 (from jsonschema) 13:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:56 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:56 INFO - warning: no files found matching '*.txt' 13:17:56 INFO - no previously-included directories found matching 'build' 13:17:56 INFO - no previously-included directories found matching 'dist' 13:17:56 INFO - no previously-included directories found matching '.git*' 13:17:56 INFO - Installing collected packages: jsonschema, functools32 13:17:56 INFO - Running setup.py install for functools32 13:17:56 INFO - warning: no files found matching '*.txt' 13:17:56 INFO - no previously-included directories found matching 'build' 13:17:56 INFO - no previously-included directories found matching 'dist' 13:17:56 INFO - no previously-included directories found matching '.git*' 13:17:56 INFO - Successfully installed jsonschema functools32 13:17:56 INFO - Cleaning up... 13:17:56 INFO - Return code: 0 13:17:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:17:56 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')]} 13:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:56 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')]} 13:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:56 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 0x10bf41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b56a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, '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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:56 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 13:17:56 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 13:17:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:17:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:56 INFO - 'HOME': '/Users/cltbld', 13:17:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:56 INFO - 'LOGNAME': 'cltbld', 13:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:56 INFO - 'MOZ_NO_REMOTE': '1', 13:17:56 INFO - 'NO_EM_RESTART': '1', 13:17:56 INFO - 'PAGER': '/bin/cat', 13:17:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:56 INFO - 'PWD': '/builds/slave/test', 13:17:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:56 INFO - 'SHELL': '/bin/bash', 13:17:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:17:56 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:17:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:56 INFO - 'USER': 'cltbld', 13:17:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:56 INFO - 'XPC_FLAGS': '0x0', 13:17:56 INFO - 'XPC_SERVICE_NAME': '0', 13:17:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:56 INFO - Downloading/unpacking flake8 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:17:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:17:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:17:59 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 13:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:18:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:18:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:18:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:18:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:18:00 INFO - no previously-included directories found matching 'docs/_build' 13:18:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:18:00 INFO - Running setup.py install for pep8 13:18:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:18:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:18:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:18:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:18:00 INFO - no previously-included directories found matching 'docs/_build' 13:18:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:18:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:18:00 INFO - Cleaning up... 13:18:00 INFO - Return code: 0 13:18:00 INFO - Running post-action listener: _resource_record_post_action 13:18:00 INFO - Running post-action listener: _start_resource_monitoring 13:18:00 INFO - Starting resource monitoring. 13:18:00 INFO - ##### 13:18:00 INFO - ##### Running install step. 13:18:00 INFO - ##### 13:18:00 INFO - Running pre-action listener: _resource_record_pre_action 13:18:00 INFO - Running main action method: install 13:18:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:01 INFO - Reading from file tmpfile_stdout 13:18:01 INFO - Detecting whether we're running mozinstall >=1.0... 13:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:18:01 INFO - Reading from file tmpfile_stdout 13:18:01 INFO - Output received: 13:18:01 INFO - Usage: mozinstall [options] installer 13:18:01 INFO - Options: 13:18:01 INFO - -h, --help show this help message and exit 13:18:01 INFO - -d DEST, --destination=DEST 13:18:01 INFO - Directory to install application into. [default: 13:18:01 INFO - "/builds/slave/test"] 13:18:01 INFO - --app=APP Application being installed. [default: firefox] 13:18:01 INFO - mkdir: /builds/slave/test/build/application 13:18:01 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'] 13:18:01 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 13:18:34 INFO - Reading from file tmpfile_stdout 13:18:34 INFO - Output received: 13:18:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:18:34 INFO - Running post-action listener: _resource_record_post_action 13:18:34 INFO - ##### 13:18:34 INFO - ##### Running run-tests step. 13:18:34 INFO - ##### 13:18:34 INFO - Running pre-action listener: _resource_record_pre_action 13:18:34 INFO - Running main action method: run_tests 13:18:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:18:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:18:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:18:34 INFO - 2016-02-10 13:18:34.963 screenresolution[2282:15353] starting screenresolution argv=screenresolution get 13:18:34 INFO - 2016-02-10 13:18:34.965 screenresolution[2282:15353] Display 0: 1600x1200x32@60 13:18:34 INFO - 2016-02-10 13:18:34.972 screenresolution[2283:15355] starting screenresolution argv=screenresolution list 13:18:34 INFO - Available Modes on Display 0 13:18:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:18:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:18:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:18:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:18:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:18:35 INFO - Intel Iris: 13:18:35 INFO - Chipset Model: Intel Iris 13:18:35 INFO - Type: GPU 13:18:35 INFO - Bus: Built-In 13:18:35 INFO - VRAM (Dynamic, Max): 1536 MB 13:18:35 INFO - Vendor: Intel (0x8086) 13:18:35 INFO - Device ID: 0x0a2e 13:18:35 INFO - Revision ID: 0x0009 13:18:35 INFO - Displays: 13:18:35 INFO - Display: 13:18:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:18:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:18:35 INFO - Display Serial Number: 1600x1200 60 13:18:35 INFO - Main Display: Yes 13:18:35 INFO - Mirror: Off 13:18:35 INFO - Online: Yes 13:18:35 INFO - Rotation: Supported 13:18:35 INFO - Return code: 0 13:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:35 INFO - Python 2.7.3 13:18:35 INFO - Return code: 0 13:18:35 INFO - grabbing minidump binary from tooltool 13:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:35 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 0x10bde5d30>, '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 0x10bc09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bddcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:35 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 13:18:35 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 13:18:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:35 INFO - Return code: 0 13:18:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:18:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:18:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:18:36 INFO - Return code: 0 13:18:36 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/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:18:36 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/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cNf2RTzU9t/Render', 13:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:36 INFO - 'HOME': '/Users/cltbld', 13:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:36 INFO - 'LOGNAME': 'cltbld', 13:18:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:36 INFO - 'MOZ_NO_REMOTE': '1', 13:18:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:36 INFO - 'NO_EM_RESTART': '1', 13:18:36 INFO - 'PAGER': '/bin/cat', 13:18:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:36 INFO - 'PWD': '/builds/slave/test', 13:18:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:36 INFO - 'SHELL': '/bin/bash', 13:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TcJwOITVWZ/Listeners', 13:18:36 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:36 INFO - 'USER': 'cltbld', 13:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:36 INFO - 'XPC_FLAGS': '0x0', 13:18:36 INFO - 'XPC_SERVICE_NAME': '0', 13:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:36 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/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:18:36 INFO - mozversion application_buildid: 20160210093439 13:18:36 INFO - mozversion application_changeset: 15af46c34a81788cf616367148f00e3d0950122a 13:18:36 INFO - mozversion application_display_name: Nightly 13:18:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:36 INFO - mozversion application_name: Firefox 13:18:36 INFO - mozversion application_remotingname: firefox 13:18:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:18:36 INFO - mozversion application_vendor: Mozilla 13:18:36 INFO - mozversion application_version: 47.0a1 13:18:36 INFO - mozversion platform_buildid: 20160210093439 13:18:36 INFO - mozversion platform_changeset: 15af46c34a81788cf616367148f00e3d0950122a 13:18:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:18:36 INFO - mozversion platform_version: 47.0a1 13:18:36 INFO - using testdate: 1455139116 13:18:36 INFO - actual date: 1455139116 13:18:37 INFO - starting webserver on 'localhost:51493' 13:18:37 INFO - SUITE-START | Running 2 tests 13:18:37 INFO - TEST-START | dromaeo_css 13:18:37 INFO - operating with platform_type : mac_ 13:18:37 INFO - Initialising browser for dromaeo_css test... 13:18:37 INFO - TEST-INFO | started process 2301 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpP5yxy4/profile http://localhost:51493/getInfo.html) 13:18:39 INFO - PROCESS | 2301 | __metrics Screen width/height:1600/1200 13:18:39 INFO - PROCESS | 2301 | colorDepth:24 13:18:39 INFO - PROCESS | 2301 | Browser inner width/height: 1024/689 13:18:39 INFO - PROCESS | 2301 | __metrics 13:18:39 INFO - PROCESS | 2301 | 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" 13:18:39 INFO - PROCESS | 2301 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:18:40 INFO - TEST-INFO | 2301: exit 0 13:18:40 INFO - Browser initialized. 13:18:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:40 INFO - TEST-INFO | started process 2304 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpP5yxy4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:52 INFO - PROCESS | 2304 | RSS: Main: 246726656 13:18:52 INFO - PROCESS | 2304 | 13:19:43 INFO - PROCESS | 2304 | 1455139183035 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] 13:21:53 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51493/tests/dromaeo/cssquery-ext.html) 13:21:54 INFO - PROCESS | 2304 | RSS: Main: 368680960 13:21:54 INFO - PROCESS | 2304 | 13:24:57 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-ext.html (next: http://localhost:51493/tests/dromaeo/cssquery-jquery.html) 13:24:57 INFO - PROCESS | 2304 | RSS: Main: 381902848 13:24:57 INFO - PROCESS | 2304 | 13:28:00 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51493/tests/dromaeo/cssquery-mootools.html) 13:28:00 INFO - PROCESS | 2304 | RSS: Main: 380874752 13:28:00 INFO - PROCESS | 2304 | 13:31:02 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51493/tests/dromaeo/cssquery-prototype.html) 13:31:03 INFO - PROCESS | 2304 | RSS: Main: 345366528 13:31:03 INFO - PROCESS | 2304 | 13:34:06 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51493/tests/dromaeo/cssquery-yui.html) 13:34:07 INFO - PROCESS | 2304 | RSS: Main: 341061632 13:34:07 INFO - PROCESS | 2304 | 13:37:09 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-yui.html (next: http://localhost:51493/tests/dromaeo/cssquery-dojo.html) 13:37:09 INFO - PROCESS | 2304 | RSS: Main: 425156608 13:37:09 INFO - PROCESS | 2304 | 13:37:09 INFO - PROCESS | 2304 | __start_tp_report 13:37:09 INFO - PROCESS | 2304 | _x_x_mozilla_page_load 13:37:09 INFO - PROCESS | 2304 | _x_x_mozilla_page_load_details 13:37:09 INFO - PROCESS | 2304 | |i|pagename|runs| 13:37:09 INFO - PROCESS | 2304 | |0;dojo.html;3402.0814380117367;3458.2910503346807;3466.9826650866726;3481.56480439945;3534.134137136402;5588.832335029955;5624.521915637166;5656.547476201904;5660.688662123582;5682.062459694156;4701.506341834101;5541;5583.5254003409755;5718.342390625079;5748.626339287944;5057.544820966113;5109.080365534193;5112.437631860493;5136.101182293102;5198.896022079556;5160.225966105096;5200.661956972804;5219.817306394277;5220.138677118271;5271.209318602202;5065.138926382506;5069.493050694938;5154.768035438415;5155.123628983082;5201.271821944931;5122.743862806882;5132.153194722866;5153.252778347156;5153.742312884341;5164.870878228036;5076.543111120017;5111.616628752859;5116.820911268088;5119.539241468286;5128.179491281415;5470.343558772933;5491.039068163055;5532.502074813246;5534.972325138388;5556;6186.19579454668;6219.782307619212;6224.439800417938;6232.376762323776;6233.5013198944425;6236.532260080512;6272.372762723691;6288.968555157241;6309.305976342599;6311.116443697886;5623.690697011662;5702.971485142548;5741.425857414309;5753.568482363798;5797.420257974169;6293.465055470337;6334.049892516067;6347.206599175103;6347.777827776098;6357.1735674362035;6058.666773327421;6085.726142323518;6112.235970503687;6124.755009799558;6135.96932015346;6105.542084343692;6131.315499379051;6168.845778855564;6195.752169913243;6230.937690623035;6155.4767844732805;6162.22972128484;6168.92043892326;6174.44430001302;6176.505879529627;6033.396660333931;6213.906791398133;6216.316205217422;6223.906641400383;6232.3144454110015;4821.180399332052;4835.20219163834;4852.126617208936;4884.413870335511;4887.511248875155;4359.825606975749;4374.518802931675;4406.427164468599;4413.205622987893;4427.889302767457;5485.259489968883;5583.525400341016;5647.774089036392;5661.688607126647;5708.20085188074;5927.2590926134235;6123.25211838015;6133.44798968095;6185.165002724664;6238.937610623926;5605.243292155506;5606.831795046155;5626.746796394172;5631.324241091095;5635.6618602883955;5261.421243663194;5319.2021196820015;5327.9733601331745;5331.840044798662;5348.224507446398;6221.62670239769;6321.7787377440645;6322.462590679752;6323.588966717149;6369.235691717024;6267.843303917439;6284.591501552384;6284.748610055546;6294.748210071729;6306.085617585516;5285.233641122093;6150.969245153746;6293.842653933688;6301.558890877594;6311.431971122621;5998.34018258;6104.4505994460715;6116;6161.322254552086;6167.105769663463;6259.874802503833;6278;6279.466245369194;6294.433500984934;6317.526185536011;5165.302684137743;6055.061465472859;6092.664903430354;6111.083337499411;6112.388761123852;4616.353710480468;5940.762369505172;5984.910226346521;6095.786647467317;6097;5808.970955145197;5831.679257640871;5879.882402352015;5886.117082437498;5899;5875.41245875409;6036.577439579188;6063.727132279147;6070.666113363631;6123.938760612336;5869.119632055055;5885.852853678521;5949.8215053548465;5971.731272092853;6011.549133814894 13:37:09 INFO - PROCESS | 2304 | |1;ext.html;454.8135264541539;470.3931927813121;533.6397931396308;539.1212323912023;558.265880367317;21806.781932180675;29368;29402.85298573507;29431;29482.705172948263;38428.42357364642;39291.0177245569;39309.01727456815;39374.80312598433;39422.80288598553;9527.857082143755;9716.174125199366;9725.416475011521;9729.70810875675;9733.2213422926;9496.66761663342;9641.42151470914;9642.903570964305;9644;9668.806623867553;9617.519124043805;9682.56428460721;9685.32202745808;9686.32195746298;9687.128158465737;9555.474448905308;9658.3722058066;9659.565319560566;9678.032196780336;9688.418694878295;8597.914020859836;9358.812823743556;9443.480608566526;9675.70972870815;9696.563654635558;39183.60816391828;39678.80160599208;39739.60260397388;39771.60228397708;39837.80486585407;3306.024722706783;3362.411577973869;3375.1899544109483;3438.638942911008;3561.8397172127316;28223.435531289466;28481;28708.138755837357;28724;29271;2734.617153598478;2780.7775377969715;2860.7139286071433;2983.8209707417623;2985.089547687954;466116.66941665416;467083;467384;470755;471293.99999999657;47980;51788.223176652384;52936.735316323175;60052.69973650104;60976.39023609707;60021.399786002454;60169;60660;60734.08898866521;60756;16055.759163612554;16238.837611623969;16251.59371015734;16304.51086467384;16336.75494867578;11370.97661210495;11538.480768365444;12271.202371845802;12390.690232744253;12404.25574465535;18198.818011819978;18202.54493637643;18215.362462313755;18221.18004689792;18299.359522416653;8040.195980401913;8230.09468958414;8232.62953167109;8250.504969701837;8282.751517454486;929.846575315079;940.8165407745424;1039.2361614213546;1086.1907878630313;1196.3180986837592;29468.705312946597;29549.556756648668;30510;30592.27895392279;30628.69371306303;1063.2450959818616;1110.3948348150116;1141.9950443609737;1142.6115120858947;1187.976240475203;13854.991026301332;14016.772975429947;14150.504732334319;14239.288035598385;14253.572392828231;540176;542540;545834;547926;549347;52585;52916.73541632267;52929.47070529246;52951.73524132355;52995.20507192395;1405.3605609447677;1407.6551244945053;1430.2991534147984;1433.3908089062106;1434.6556826361598;24838.50322993566;26172;27271.909123634832;27334.589981150697;28076.85961570179;47620.76189619168;47966.76016619895;47989.280160796916;48082;48118.51881481281;481310;503803;539014;539290;543541;28860;29048.419031619673;29186;29214.561781573717;29288.828446861888;40009.599904000585;41624.16751664889;41755.7912210437;41813.74558763242;42168.78915605402;34142.487862681584;34840.82579587086;35397.82301088478;35715.82142089273;35893.82053089718;34249.48625770665;35027.649723502436;35259.82370088133;35342.11644708903;35405.46891796677;35009.62379702537;35270.47094293639;35272.11819704528;35393.646063540065;35893;29472.410551788416;30505;30506;30628;30676.84661576678;23596.410089747893;23997.760022400253;24037.75962240425;24523;24575.262742117764 13:37:09 INFO - PROCESS | 2304 | |2;jquery.html;358.546438754975;364.29327105415507;368.13855577947606;368.6921420613787;370.8701954315988;13243.933780331108;14391.352389142488;15187.77218341723;19009.809901900975;19916.99999999998;19759;19984.400467985983;20481.385558433234;20871.47821304468;20892.477688057766;6338.239411270631;6562.507811914102;6576.572522786028;6582.802515924506;6589.703463344137;4539.659525535581;4619.653525985547;4751.574527641711;6534.281229064799;7055.85888282234;7028.191757947825;7292.708291668353;7300.868365403371;7339.706411743524;7341.669624866894;6980.616066116361;7205.135383753931;7254.165770936357;7259.528130671516;7271.999999999974;6794.592324460548;6863.691133898987;6874.690638921261;6884.311568843125;6885;21470.033848476854;23989.760102398926;24468.26595202147;25235.62146567803;25551.85016674254;2202.25123458025;2442.8778561072054;2449.9387515312083;2455.1161581830706;2479.5784716598223;14690.632734181625;15092.924535377253;15200.16399098049;15352.232388380648;15714.842851571453;1852.6202128563748;1884.8586356023352;1930.1217945834612;1955.9706604400944;1982.900854957261;82683.17316826814;84573.57713211395;86518;86848.13151868463;87138.28617138299;10531.315464494783;10828.837567436494;10966.616168434066;10978.517900083547;11051.502682379312;13034.152780069455;13155.67110822218;13161.210327380388;13162.078654494093;13177.538786142632;8219.54792486419;8261.339092872557;8265.586720663943;8345.54099524532;8388.203120703523;8506.447080939843;8508.149185081442;8514.403991720521;8614.784630384165;8622.223999840044;4025.4766880305374;4164.75011499311;4364.5635436456105;4448.021435284232;4501;1792.211426972128;1847.5011746828282;1850.1859181959894;1854.3880519428556;1855.7587513623143;871.4205053639386;921.4149015375285;940.7695114696807;1001.4892404873567;1060.5121644043672;16081.195940202942;16880.240389182516;17406.738898916527;18180.36368727088;20334.796652033292;817.6198067898337;917.687986084721;936.9203617692573;970.8883478400074;971.1114330387617;8731;10379.06588407047;10691.889893220921;10722.52228866942;10865.005119844125;728254;728858;736800;742827;749714;104165;105167;105425;107369.46315268373;109835;1055.773008803111;1080.1790639114329;1103.6027030269097;1105.618561596248;1112.57165991094;16787.496375108767;17703.760736748303;17730.36527511831;17740.379086731904;18015.459536213933;48994.26508602303;49681;49739;50199.74900125476;51774.223386648475;64871;67319;67463.32536674767;67847;68001.65999169972;7604.80987975305;7750.883736743841;7803.375729941477;7804.6878124874365;7822;11184.161187911102;11229.494672739584;11792.70518237051;11916.880831191924;12266.877331226931;10199.0820826126;10358.741031474274;10507.15942724565;10548.314359566604;10679.839802403125;7181.928180718335;10022.09359285799;10048.09567138961;10335.896641033794;10502.159827213653;9639.373440726331;9853.507324633883;10344.741381465523;10491.370517768959;10755.247132700635;7492.40060795146;7553.546787192786;7644.923550764421;7673;7699.8075048122;8275.296599788844;10405.739856503647;10622.36265824053;10630.149588032784;10660.200484963814 13:37:09 INFO - PROCESS | 2304 | |3;mootools.html;1342.3892129081269;1503.4286970951039;1532.7011232809602;1767.4874286456927;1943.7278780970667;7916.802079947997;8109.107998120202;8117.228863257981;8129.146439623828;8132.349412047037;8419.536925469096;8531.123152906366;8650.480971141737;8657.69698060568;8666.696665616704;2424.5999410097356;2488.1167185649015;2493.750624937501;2493.987530062347;2496.5256601245796;2150.63439215333;2211.966820497694;2214.2250212425683;2217.2018073493527;2426.162973774054;2155.5473350596394;2394;2442.743511931248;2443.8778061096964;2451.191106934716;2399.148302352657;2429.8299119061585;2431.3921519620094;2459.1638842793536;2466.6176742604925;2132.3816093332916;2200.9559808803733;2399.4121440247077;2456.1403508771964;2469.1111199967995;8570.957145214297;8655.350848686374;8669;8674.436161649473;8699.60851761666;5300.787968481256;5441.945580544223;5445.727713614304;5447.073997420448;5450.754716037788;3592;3681.834317455721;3746.38184699527;3764.9435258471144;3765.246950609889;1046.2414749306768;1063.7287491689647;1070.0797314309686;1101.0750969185842;1102.0522350778324;12182.208156469802;12213.572524961584;12218.20581662189;12232.388380580935;12233.143679942408;4877.5366340197625;4899.387576552931;4975.353204083518;4990.675606085593;4994.2508623706735;10203.38779673222;10207.387556746618;10221.488925553842;10225.693229203136;10245;5507.834764957058;5511.173324001432;5519.420460851553;5521.806736764194;5528.834134975958;4918.0901533216465;4926.9014619707405;4986.650934434628;5004.724740139327;5009.974950125299;3919.7648141111627;3968.8214030368704;3969.80150992455;3997.140614767839;4013.5986401359633;1302.947882084706;1313.4680454415977;1319.9472021119047;1328.913620614657;1330.9267990260628;1086.3481910853582;1100.5762781329086;1231.4889320931893;1292.0761655416422;1303.328785675378;8230.382721295926;8237.629306681214;8248.793780155424;8261.17388261181;8264.132266112092;508.14056917641045;517.9378474583074;521.0516859316009;521.8695326168458;522.0941666209125;5875.148103525051;5968.970155149196;5978.1929439525975;6034.2155519782145;6184.319724830265;9538.093881081286;10622.787544249071;10772.407517586607;10780.568777248978;10785.514651840685;10283.794324113625;10613.84079238812;10638.574457021787;10657.094146997437;10690.839637405445;8009.718445048764;8220.972378452694;8343.207395297437;8365.8326833463;8434.114417986024;7287.27127287267;7822.491538050009;8073.717419890276;8105.513669179868;8130.715424960098;9459.148676618863;9459.195968342769;9536.284778641768;9539.761505962406;9682.951585242028;9563.569639366106;9973.152282056106;9987.151092156957;10035.297529172887;10080.54637541327;7367.373773229336;7449.404047676281;7481.551106933602;7576.583287919218;7584.08990921093;6238.781642642486;8274.793130171553;8279.917200828155;8286.875696864672;8289.958550207451;7779.883301750365;7855;7885.132635409986;8021.799455013671;8033.477823941425;7704.8073798153255;7715.729949451742;7739.651715672696;7821.843563128819;7854.136045035156;7896.368290536629;7967.2431119043595;7967.402444816546;7970.442069055111;7974.362051036019;7073.540219885691;7133.607651579213;7137.785866424016;7168.856622867618;7193.280671932974;6476.319986401549;6641.236257830411;7005.369516743517;7255.56466612005;7335.376492998155 13:37:09 INFO - PROCESS | 2304 | |4;prototype.html;316.5584010305624;323.3774983157421;328.7945034353529;330.57851239669435;335.37285276532884;6641.335866413357;6648.534602577809;6658.9001164982565;6664.600123992564;6687.86624267515;6314.305426403092;6489.156409666737;6520.836979075525;6525.151730275057;6590.439812615933;3961.861334853281;4846.927296090562;4874.439439464454;4884.902301953959;4894.755262236892;4623.4451865776155;4873;4898.24077268024;4898.412190537123;4902.994886048352;4674.626029917598;4694.460137084245;4763.14263432582;4771.570558649721;4777.713337199762;4761.59526440253;4763.904721905577;4778.378810754597;4796.952030479685;4797.9760101199445;4127.7936103194725;4127.894773665422;4129.070959034223;4136.9793151034355;4137.834486620532;6154.63072215664;6370.299267080617;6383.234011918553;6383.840403989938;6433.163688720483;5720;5722.313322401297;5730.856728581777;5737.627054241461;5738.024535828878;7014.929850701478;7027.718891244344;7029.613371264579;7042.894356584656;7060.470464715116;4651.302304654295;4669.4630117536235;4677.602403795681;4681.438227412698;4689.742064186468;6627.469802415795;6853.862922741567;7100.28997100291;7439.181690014094;7467.850642987164;4558.817647294071;4593.931091033637;4600.88497787558;4606.470255920545;4614.838480653161;4671.6262698984;4671.948811517449;4686.81252749893;4695.647826413033;4696.9060618787435;5439.456054394529;5603.047481928082;5603.831885043455;5609.411011843697;5625.128105143709;5735.627184233012;7102.18324892644;7113.3953613943395;7121.394681452135;7127.501074924706;1604.9117298548458;1617.7573363995496;1625.5936015996;1626.5608285762778;1626.7397216445313;1019.3781793106348;1026.6663334416344;1036.8341065429645;1043.3635482355758;1051.6371851711147;5732.111522713986;6234.1583886174785;6579.276279609239;6586.176727909012;6593.241777195684;7095.325944035309;7185.820354491075;7359.153697324769;7383.335499805044;7449.366803821736;5686.943130568724;6000.639961602318;6472.838179045561;6526.34736526353;6548.967255163789;3861.092643228839;3879.18537107205;3891.2217556488818;3903.687704983651;3911.6088391161225;7427.925720742724;7717.305442510201;7724.92275077242;7744.6514906829325;7751.689932402641;7626.275503827128;7633.847323053619;7636.541807491568;7636.694532218649;7644.770656880302;6276.497880169484;7719.680537368873;7732.149463559116;7734.883976740353;7757;7128.28717128283;7392.926070739224;7399.112106547249;7402;7410.147832999274;7262.96368518154;7275.272472752894;7279.053723015974;7280.126384833854;7288.380487658608;5996.610220335664;7488.213737557478;7705.460617756703;7722.53664780115;7741.45809793309;4492.618127459072;4612.654050946259;4625.329327247463;4627.375304333872;4629.236176031052;7345.228750981284;7345.742898998509;7359;7366.705331786883;7369.299916507923;6860.211075726355;7082.0793296873135;7092.5389849659605;7097.645117744195;7125.67934442941;7052.224255332012;7120.608366539683;7126.394256488256;7130.7147714092935;7133.286671332825;6922.619255940972;6930.48021398387;6936.653167341512;6949.409300209539;6960;6909.205441374306;7083.82290442743;7089.82275443118;7091.858162836611;7101.041359416413;5603.551715862803;6689.832754181184;6946.722131114699;6959.89560156588;6960.4779641526075 13:37:09 INFO - PROCESS | 2304 | |5;yui.html;650.3561474140596;651.7458191305388;675.1762849323825;714.6176795414455;751.1099347273481;14483.493077742281;14700;14709.411623535047;14723.558293251219;14727.48453804117;12533.749325013494;13217.735645287088;13331.400086996084;13346.66633334167;13383.263920484369;864.4726716702822;881.3081730841259;882.7528292078229;886.0740526150156;886.9645214191424;880.058337578791;884.0143240287098;884.3411658314565;887.8890138732659;888.471359541072;922.1654402765508;927.8469052606312;928.6610387208688;929.7815013471828;934.4953724988499;918.361738591679;921.3688623293066;923.0723123261113;928.6192661008954;928.9349745517817;687.3573209049555;688.6246995387526;688.9104416425882;688.9207741109786;691.7820886420811;12474.81287780684;12500.437480313407;12509.937450312782;12511.499540018389;12543.310117943509;11161.665150045512;11181.776364472666;11241.437928103562;11308.604198853001;11320.6037788677;9404.62381504739;9529.714108576754;9545.52272386378;9585.520723963775;9628.951855240679;3415.487676848493;3459.3427248822645;3460.0311912664242;3465.740069494773;3469.8785542506143;59826.50433739148;75345;78813;78931;79755.6012219941;7797.7660670179985;9491.335606507479;9589.184919281799;10007.699769006942;10206.795864082826;20602.175912963612;20942.057607407703;20971.8951405242;20987;21002;7409.666565004588;7653.693852245848;7673.194314596999;7717.382609391235;7803.80490487731;4097.426360309559;4141.171765646883;4153.003279212967;4171.749695018309;4173.707840451139;3407.1993081625797;3465.740069494798;3469.8612055517497;3472.7048200903205;3476.461148521983;615.2002396884122;627.5450298533526;627.5575719118011;647.064991087883;648.011782032395;582.484501216418;606.6966516741629;627.2253766598247;630.5838146823074;642.9357064293627;8127.878081828777;8547.529885856213;8661.653533858575;8857;8920.955395222982;527.7044854881278;572.2074926227123;594.521410264741;600.7296716477603;603.1405247522263;3868.361720316116;3923.705722070856;4035.9798201008807;4070.1859628074503;4185.330347144442;88643.67034494488;90041.54979225193;90138.09861901429;96628.51685741526;97873;59891;72366.27633723701;76196;76212.61893690495;81169.18830811616;70906.64546677233;71012.2898771016;71349.6432517834;72161.63919180476;72619;8039.356851451753;8189.631466584137;8383.496990180609;9038.231750301298;9081.137291957253;49020.2646960303;50609.49390506195;51522.48477515177;52435.73782131065;52796.47203528069;61541.69229153825;66347.67304653784;72958.54082918206;73057.63471182823;74584.62707686427;10099.848502272325;11050.668479945614;11053.723656908642;11137.777244455228;11355.261907975955;11112.77759446444;12121.15151939391;12310.446029928495;12384.75230495367;12503.437345319664;11133.83299250528;11613.883861161617;11851.881481185077;12026.939865300617;12327.815082773945;9078.682246121354;11821.645350639494;11930.105242106703;11945;12228.02175825914;10540.841887371542;11146.442677866236;11362.431878406212;11735.119866009913;11771.823422648496;9414.105659962293;9424.198943089914;9524.285678573997;9579.856302155613;10320.071193592612;8997.415168014059;9153.633854646007;9239.353245272767;9625.374350667184;10074.647387341407 13:37:09 INFO - PROCESS | 2304 | __end_tp_report 13:37:09 INFO - PROCESS | 2304 | __start_cc_report 13:37:09 INFO - PROCESS | 2304 | _x_x_mozilla_cycle_collect,1156 13:37:09 INFO - PROCESS | 2304 | __end_cc_report 13:37:09 INFO - PROCESS | 2304 | __startTimestamp1455140229984__endTimestamp 13:37:09 INFO - PROCESS | 2304 | 13:37:09 INFO - PROCESS | 2304 | ------- Summary: start ------- 13:37:09 INFO - PROCESS | 2304 | Number of tests: 6 13:37:09 INFO - PROCESS | 2304 | 13:37:10 INFO - PROCESS | 2304 | [#0] dojo.html Cycles:165 Average:5681.02 Median:5879.88 stddev:644.95 (11.0%) stddev-sans-first:621.66 13:37:10 INFO - PROCESS | 2304 | Values: 3402.1 3458.3 3467.0 3481.6 3534.1 5588.8 5624.5 5656.5 5660.7 5682.1 4701.5 5541.0 5583.5 5718.3 5748.6 5057.5 5109.1 5112.4 5136.1 5198.9 5160.2 5200.7 5219.8 5220.1 5271.2 5065.1 5069.5 5154.8 5155.1 5201.3 5122.7 5132.2 5153.3 5153.7 5164.9 5076.5 5111.6 5116.8 5119.5 5128.2 5470.3 5491.0 5532.5 5535.0 5556.0 6186.2 6219.8 6224.4 6232.4 6233.5 6236.5 6272.4 6289.0 6309.3 6311.1 5623.7 5703.0 5741.4 5753.6 5797.4 6293.5 6334.0 6347.2 6347.8 6357.2 6058.7 6085.7 6112.2 6124.8 6136.0 6105.5 6131.3 6168.8 6195.8 6230.9 6155.5 6162.2 6168.9 6174.4 6176.5 6033.4 6213.9 6216.3 6223.9 6232.3 4821.2 4835.2 4852.1 4884.4 4887.5 4359.8 4374.5 4406.4 4413.2 4427.9 5485.3 5583.5 5647.8 5661.7 5708.2 5927.3 6123.3 6133.4 6185.2 6238.9 5605.2 5606.8 5626.7 5631.3 5635.7 5261.4 5319.2 5328.0 5331.8 5348.2 6221.6 6321.8 6322.5 6323.6 6369.2 6267.8 6284.6 6284.7 6294.7 6306.1 5285.2 6151.0 6293.8 6301.6 6311.4 5998.3 6104.5 6116.0 6161.3 6167.1 6259.9 6278.0 6279.5 6294.4 6317.5 5165.3 6055.1 6092.7 6111.1 6112.4 4616.4 5940.8 5984.9 6095.8 6097.0 5809.0 5831.7 5879.9 5886.1 5899.0 5875.4 6036.6 6063.7 6070.7 6123.9 5869.1 5885.9 5949.8 5971.7 6011.5 13:37:10 INFO - PROCESS | 2304 | 13:37:10 INFO - PROCESS | 2304 | [#1] ext.html Cycles:180 Average:63923.72 Median:35804.41 stddev:136750.97 (381.9%) stddev-sans-first:137051.56 13:37:10 INFO - PROCESS | 2304 | Values: 454.8 470.4 533.6 539.1 558.3 21806.8 29368.0 29402.9 29431.0 29482.7 38428.4 39291.0 39309.0 39374.8 39422.8 9527.9 9716.2 9725.4 9729.7 9733.2 9496.7 9641.4 9642.9 9644.0 9668.8 9617.5 9682.6 9685.3 9686.3 9687.1 9555.5 9658.4 9659.6 9678.0 9688.4 8597.9 9358.8 9443.5 9675.7 9696.6 39183.6 39678.8 39739.6 39771.6 39837.8 3306.0 3362.4 3375.2 3438.6 3561.8 28223.4 28481.0 28708.1 28724.0 29271.0 2734.6 2780.8 2860.7 2983.8 2985.1 466116.7 467083.0 467384.0 470755.0 471294.0 47980.0 51788.2 52936.7 60052.7 60976.4 60021.4 60169.0 60660.0 60734.1 60756.0 16055.8 16238.8 16251.6 16304.5 16336.8 11371.0 11538.5 12271.2 12390.7 12404.3 18198.8 18202.5 18215.4 18221.2 18299.4 8040.2 8230.1 8232.6 8250.5 8282.8 929.8 940.8 1039.2 1086.2 1196.3 29468.7 29549.6 30510.0 30592.3 30628.7 1063.2 1110.4 1142.0 1142.6 1188.0 13855.0 14016.8 14150.5 14239.3 14253.6 540176.0 542540.0 545834.0 547926.0 549347.0 52585.0 52916.7 52929.5 52951.7 52995.2 1405.4 1407.7 1430.3 1433.4 1434.7 24838.5 26172.0 27271.9 27334.6 28076.9 47620.8 47966.8 47989.3 48082.0 48118.5 481310.0 503803.0 539014.0 539290.0 543541.0 28860.0 29048.4 29186.0 29214.6 29288.8 40009.6 41624.2 41755.8 41813.7 42168.8 34142.5 34840.8 35397.8 35715.8 35893.8 34249.5 35027.6 35259.8 35342.1 35405.5 35009.6 35270.5 35272.1 35393.6 35893.0 29472.4 30505.0 30506.0 30628.0 30676.8 23596.4 23997.8 24037.8 24523.0 24575.3 13:37:10 INFO - PROCESS | 2304 | 13:37:10 INFO - PROCESS | 2304 | [#2] jquery.html Cycles:180 Average:36767.68 Median:25393.74 stddev:121012.47 (476.5%) stddev-sans-first:121321.05 13:37:10 INFO - PROCESS | 2304 | Values: 358.5 364.3 368.1 368.7 370.9 13243.9 14391.4 15187.8 19009.8 19917.0 19759.0 19984.4 20481.4 20871.5 20892.5 6338.2 6562.5 6576.6 6582.8 6589.7 4539.7 4619.7 4751.6 6534.3 7055.9 7028.2 7292.7 7300.9 7339.7 7341.7 6980.6 7205.1 7254.2 7259.5 7272.0 6794.6 6863.7 6874.7 6884.3 6885.0 21470.0 23989.8 24468.3 25235.6 25551.9 2202.3 2442.9 2449.9 2455.1 2479.6 14690.6 15092.9 15200.2 15352.2 15714.8 1852.6 1884.9 1930.1 1956.0 1982.9 82683.2 84573.6 86518.0 86848.1 87138.3 10531.3 10828.8 10966.6 10978.5 11051.5 13034.2 13155.7 13161.2 13162.1 13177.5 8219.5 8261.3 8265.6 8345.5 8388.2 8506.4 8508.1 8514.4 8614.8 8622.2 4025.5 4164.8 4364.6 4448.0 4501.0 1792.2 1847.5 1850.2 1854.4 1855.8 871.4 921.4 940.8 1001.5 1060.5 16081.2 16880.2 17406.7 18180.4 20334.8 817.6 917.7 936.9 970.9 971.1 8731.0 10379.1 10691.9 10722.5 10865.0 728254.0 728858.0 736800.0 742827.0 749714.0 104165.0 105167.0 105425.0 107369.5 109835.0 1055.8 1080.2 1103.6 1105.6 1112.6 16787.5 17703.8 17730.4 17740.4 18015.5 48994.3 49681.0 49739.0 50199.7 51774.2 64871.0 67319.0 67463.3 67847.0 68001.7 7604.8 7750.9 7803.4 7804.7 7822.0 11184.2 11229.5 11792.7 11916.9 12266.9 10199.1 10358.7 10507.2 10548.3 10679.8 7181.9 10022.1 10048.1 10335.9 10502.2 9639.4 9853.5 10344.7 10491.4 10755.2 7492.4 7553.5 7644.9 7673.0 7699.8 8275.3 10405.7 10622.4 10630.1 10660.2 13:37:10 INFO - PROCESS | 2304 | 13:37:10 INFO - PROCESS | 2304 | [#3] mootools.html Cycles:180 Average:6053.88 Median:2911.44 stddev:3229.98 (110.9%) stddev-sans-first:3219.63 13:37:10 INFO - PROCESS | 2304 | Values: 1342.4 1503.4 1532.7 1767.5 1943.7 7916.8 8109.1 8117.2 8129.1 8132.3 8419.5 8531.1 8650.5 8657.7 8666.7 2424.6 2488.1 2493.8 2494.0 2496.5 2150.6 2212.0 2214.2 2217.2 2426.2 2155.5 2394.0 2442.7 2443.9 2451.2 2399.1 2429.8 2431.4 2459.2 2466.6 2132.4 2201.0 2399.4 2456.1 2469.1 8571.0 8655.4 8669.0 8674.4 8699.6 5300.8 5441.9 5445.7 5447.1 5450.8 3592.0 3681.8 3746.4 3764.9 3765.2 1046.2 1063.7 1070.1 1101.1 1102.1 12182.2 12213.6 12218.2 12232.4 12233.1 4877.5 4899.4 4975.4 4990.7 4994.3 10203.4 10207.4 10221.5 10225.7 10245.0 5507.8 5511.2 5519.4 5521.8 5528.8 4918.1 4926.9 4986.7 5004.7 5010.0 3919.8 3968.8 3969.8 3997.1 4013.6 1302.9 1313.5 1319.9 1328.9 1330.9 1086.3 1100.6 1231.5 1292.1 1303.3 8230.4 8237.6 8248.8 8261.2 8264.1 508.1 517.9 521.1 521.9 522.1 5875.1 5969.0 5978.2 6034.2 6184.3 9538.1 10622.8 10772.4 10780.6 10785.5 10283.8 10613.8 10638.6 10657.1 10690.8 8009.7 8221.0 8343.2 8365.8 8434.1 7287.3 7822.5 8073.7 8105.5 8130.7 9459.1 9459.2 9536.3 9539.8 9683.0 9563.6 9973.2 9987.2 10035.3 10080.5 7367.4 7449.4 7481.6 7576.6 7584.1 6238.8 8274.8 8279.9 8286.9 8290.0 7779.9 7855.0 7885.1 8021.8 8033.5 7704.8 7715.7 7739.7 7821.8 7854.1 7896.4 7967.2 7967.4 7970.4 7974.4 7073.5 7133.6 7137.8 7168.9 7193.3 6476.3 6641.2 7005.4 7255.6 7335.4 13:37:10 INFO - PROCESS | 2304 | 13:37:10 INFO - PROCESS | 2304 | [#4] prototype.html Cycles:180 Average:5753.27 Median:6505.00 stddev:1850.01 (28.4%) stddev-sans-first:1809.64 13:37:10 INFO - PROCESS | 2304 | Values: 316.6 323.4 328.8 330.6 335.4 6641.3 6648.5 6658.9 6664.6 6687.9 6314.3 6489.2 6520.8 6525.2 6590.4 3961.9 4846.9 4874.4 4884.9 4894.8 4623.4 4873.0 4898.2 4898.4 4903.0 4674.6 4694.5 4763.1 4771.6 4777.7 4761.6 4763.9 4778.4 4797.0 4798.0 4127.8 4127.9 4129.1 4137.0 4137.8 6154.6 6370.3 6383.2 6383.8 6433.2 5720.0 5722.3 5730.9 5737.6 5738.0 7014.9 7027.7 7029.6 7042.9 7060.5 4651.3 4669.5 4677.6 4681.4 4689.7 6627.5 6853.9 7100.3 7439.2 7467.9 4558.8 4593.9 4600.9 4606.5 4614.8 4671.6 4671.9 4686.8 4695.6 4696.9 5439.5 5603.0 5603.8 5609.4 5625.1 5735.6 7102.2 7113.4 7121.4 7127.5 1604.9 1617.8 1625.6 1626.6 1626.7 1019.4 1026.7 1036.8 1043.4 1051.6 5732.1 6234.2 6579.3 6586.2 6593.2 7095.3 7185.8 7359.2 7383.3 7449.4 5686.9 6000.6 6472.8 6526.3 6549.0 3861.1 3879.2 3891.2 3903.7 3911.6 7427.9 7717.3 7724.9 7744.7 7751.7 7626.3 7633.8 7636.5 7636.7 7644.8 6276.5 7719.7 7732.1 7734.9 7757.0 7128.3 7392.9 7399.1 7402.0 7410.1 7263.0 7275.3 7279.1 7280.1 7288.4 5996.6 7488.2 7705.5 7722.5 7741.5 4492.6 4612.7 4625.3 4627.4 4629.2 7345.2 7345.7 7359.0 7366.7 7369.3 6860.2 7082.1 7092.5 7097.6 7125.7 7052.2 7120.6 7126.4 7130.7 7133.3 6922.6 6930.5 6936.7 6949.4 6960.0 6909.2 7083.8 7089.8 7091.9 7101.0 5603.6 6689.8 6946.7 6959.9 6960.5 13:37:10 INFO - PROCESS | 2304 | 13:37:10 INFO - PROCESS | 2304 | [#5] yui.html Cycles:180 Average:17992.08 Median:627.55 stddev:25352.91 (4040.0%) stddev-sans-first:25390.59 13:37:10 INFO - PROCESS | 2304 | Values: 650.4 651.7 675.2 714.6 751.1 14483.5 14700.0 14709.4 14723.6 14727.5 12533.7 13217.7 13331.4 13346.7 13383.3 864.5 881.3 882.8 886.1 887.0 880.1 884.0 884.3 887.9 888.5 922.2 927.8 928.7 929.8 934.5 918.4 921.4 923.1 928.6 928.9 687.4 688.6 688.9 688.9 691.8 12474.8 12500.4 12509.9 12511.5 12543.3 11161.7 11181.8 11241.4 11308.6 11320.6 9404.6 9529.7 9545.5 9585.5 9629.0 3415.5 3459.3 3460.0 3465.7 3469.9 59826.5 75345.0 78813.0 78931.0 79755.6 7797.8 9491.3 9589.2 10007.7 10206.8 20602.2 20942.1 20971.9 20987.0 21002.0 7409.7 7653.7 7673.2 7717.4 7803.8 4097.4 4141.2 4153.0 4171.7 4173.7 3407.2 3465.7 3469.9 3472.7 3476.5 615.2 627.5 627.6 647.1 648.0 582.5 606.7 627.2 630.6 642.9 8127.9 8547.5 8661.7 8857.0 8921.0 527.7 572.2 594.5 600.7 603.1 3868.4 3923.7 4036.0 4070.2 4185.3 88643.7 90041.5 90138.1 96628.5 97873.0 59891.0 72366.3 76196.0 76212.6 81169.2 70906.6 71012.3 71349.6 72161.6 72619.0 8039.4 8189.6 8383.5 9038.2 9081.1 49020.3 50609.5 51522.5 52435.7 52796.5 61541.7 66347.7 72958.5 73057.6 74584.6 10099.8 11050.7 11053.7 11137.8 11355.3 11112.8 12121.2 12310.4 12384.8 12503.4 11133.8 11613.9 11851.9 12026.9 12327.8 9078.7 11821.6 11930.1 11945.0 12228.0 10540.8 11146.4 11362.4 11735.1 11771.8 9414.1 9424.2 9524.3 9579.9 10320.1 8997.4 9153.6 9239.4 9625.4 10074.6 13:37:10 INFO - PROCESS | 2304 | -------- Summary: end -------- 13:37:10 INFO - PROCESS | 2304 | 13:37:10 INFO - TEST-INFO | 2304: exit 0 13:37:10 INFO - TEST-OK | dromaeo_css | took 1113321ms 13:37:10 INFO - TEST-START | kraken 13:37:10 INFO - operating with platform_type : mac_ 13:37:10 INFO - Initialising browser for kraken test... 13:37:10 INFO - TEST-INFO | started process 2308 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpw6aT9p/profile http://localhost:51493/getInfo.html) 13:37:12 INFO - PROCESS | 2308 | __metrics Screen width/height:1600/1200 13:37:12 INFO - PROCESS | 2308 | colorDepth:24 13:37:12 INFO - PROCESS | 2308 | Browser inner width/height: 1024/689 13:37:12 INFO - PROCESS | 2308 | __metrics 13:37:12 INFO - PROCESS | 2308 | 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" 13:37:12 INFO - PROCESS | 2308 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:37:13 INFO - TEST-INFO | 2308: exit 0 13:37:13 INFO - Browser initialized. 13:37:13 INFO - Running cycle 1/1 for kraken test... 13:37:13 INFO - TEST-INFO | started process 2310 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpw6aT9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:25 INFO - PROCESS | 2310 | RSS: Main: 247300096 13:37:25 INFO - PROCESS | 2310 | 13:37:27 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51493/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:28 INFO - PROCESS | 2310 | RSS: Main: 294207488 13:37:28 INFO - PROCESS | 2310 | 13:37:31 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51493/tests/kraken/driver.html?testName=audio-dft) 13:37:31 INFO - PROCESS | 2310 | RSS: Main: 303972352 13:37:31 INFO - PROCESS | 2310 | 13:37:35 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51493/tests/kraken/driver.html?testName=audio-fft) 13:37:35 INFO - PROCESS | 2310 | RSS: Main: 288473088 13:37:35 INFO - PROCESS | 2310 | 13:37:37 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51493/tests/kraken/driver.html?testName=audio-oscillator) 13:37:38 INFO - PROCESS | 2310 | RSS: Main: 289722368 13:37:38 INFO - PROCESS | 2310 | 13:37:40 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51493/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:40 INFO - PROCESS | 2310 | RSS: Main: 289533952 13:37:40 INFO - PROCESS | 2310 | 13:37:43 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51493/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:44 INFO - PROCESS | 2310 | RSS: Main: 289689600 13:37:44 INFO - PROCESS | 2310 | 13:37:47 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51493/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:47 INFO - PROCESS | 2310 | RSS: Main: 291237888 13:37:47 INFO - PROCESS | 2310 | 13:37:50 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51493/tests/kraken/driver.html?testName=json-parse-financial) 13:37:51 INFO - PROCESS | 2310 | RSS: Main: 290197504 13:37:51 INFO - PROCESS | 2310 | 13:37:52 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51493/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:53 INFO - PROCESS | 2310 | RSS: Main: 327688192 13:37:53 INFO - PROCESS | 2310 | 13:37:54 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:55 INFO - PROCESS | 2310 | RSS: Main: 325357568 13:37:55 INFO - PROCESS | 2310 | 13:37:57 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:58 INFO - PROCESS | 2310 | RSS: Main: 333389824 13:37:58 INFO - PROCESS | 2310 | 13:38:00 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:38:01 INFO - PROCESS | 2310 | RSS: Main: 335757312 13:38:01 INFO - PROCESS | 2310 | 13:38:03 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:38:04 INFO - PROCESS | 2310 | RSS: Main: 336404480 13:38:04 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51493/tests/kraken/driver.html?testName=ai-astar) 13:38:06 INFO - PROCESS | 2310 | RSS: Main: 396206080 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | __start_tp_report 13:38:06 INFO - PROCESS | 2310 | _x_x_mozilla_page_load 13:38:06 INFO - PROCESS | 2310 | _x_x_mozilla_page_load_details 13:38:06 INFO - PROCESS | 2310 | |i|pagename|runs| 13:38:06 INFO - PROCESS | 2310 | |0;ai-astar;112;109;111;111;110;110;118;110;111;109 13:38:06 INFO - PROCESS | 2310 | |1;audio-beat-detection;158;118;147;156;121;140;140;119;162;119 13:38:06 INFO - PROCESS | 2310 | |2;audio-dft;184;195;186;183;185;194;263;187;188;184 13:38:06 INFO - PROCESS | 2310 | |3;audio-fft;74;73;85;79;56;62;57;83;85;83 13:38:06 INFO - PROCESS | 2310 | |4;audio-oscillator;92;93;126;79;78;82;114;77;103;152 13:38:06 INFO - PROCESS | 2310 | |5;imaging-gaussian-blur;86;91;86;92;88;91;84;92;86;91 13:38:06 INFO - PROCESS | 2310 | |6;imaging-darkroom;94;93;94;93;95;94;94;93;94;93 13:38:06 INFO - PROCESS | 2310 | |7;imaging-desaturate;85;85;87;84;88;83;90;85;86;84 13:38:06 INFO - PROCESS | 2310 | |8;json-parse-financial;53;53;53;52;52;53;53;65;51;53 13:38:06 INFO - PROCESS | 2310 | |9;json-stringify-tinderbox;62;72;74;70;68;66;65;65;68;69 13:38:06 INFO - PROCESS | 2310 | |10;stanford-crypto-aes;82;81;81;83;82;81;82;84;83;82 13:38:06 INFO - PROCESS | 2310 | |11;stanford-crypto-ccm;137;111;141;126;126;127;132;128;123;109 13:38:06 INFO - PROCESS | 2310 | |12;stanford-crypto-pbkdf2;134;143;138;137;143;174;139;137;134;136 13:38:06 INFO - PROCESS | 2310 | |13;stanford-crypto-sha256-iterative;67;67;65;67;67;67;66;67;67;66 13:38:06 INFO - PROCESS | 2310 | __end_tp_report 13:38:06 INFO - PROCESS | 2310 | __start_cc_report 13:38:06 INFO - PROCESS | 2310 | _x_x_mozilla_cycle_collect,1154 13:38:06 INFO - PROCESS | 2310 | __end_cc_report 13:38:06 INFO - PROCESS | 2310 | __startTimestamp1455140286483__endTimestamp 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | ------- Summary: start ------- 13:38:06 INFO - PROCESS | 2310 | Number of tests: 14 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.60 (2.3%) stddev-sans-first:2.74 13:38:06 INFO - PROCESS | 2310 | Values: 112.0 109.0 111.0 111.0 110.0 110.0 118.0 110.0 111.0 109.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:143.50 stddev:17.64 (12.3%) stddev-sans-first:17.16 13:38:06 INFO - PROCESS | 2310 | Values: 158.0 118.0 147.0 156.0 121.0 140.0 140.0 119.0 162.0 119.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#2] audio-dft Cycles:10 Average:194.90 Median:187.50 stddev:24.28 (12.9%) stddev-sans-first:25.43 13:38:06 INFO - PROCESS | 2310 | Values: 184.0 195.0 186.0 183.0 185.0 194.0 263.0 187.0 188.0 184.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#3] audio-fft Cycles:10 Average:73.70 Median:81.00 stddev:11.48 (14.2%) stddev-sans-first:12.18 13:38:06 INFO - PROCESS | 2310 | Values: 74.0 73.0 85.0 79.0 56.0 62.0 57.0 83.0 85.0 83.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:78.50 stddev:24.66 (31.4%) stddev-sans-first:26.01 13:38:06 INFO - PROCESS | 2310 | Values: 92.0 93.0 126.0 79.0 78.0 82.0 114.0 77.0 103.0 152.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:91.00 stddev:3.02 (3.3%) stddev-sans-first:3.04 13:38:06 INFO - PROCESS | 2310 | Values: 86.0 91.0 86.0 92.0 88.0 91.0 84.0 92.0 86.0 91.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 13:38:06 INFO - PROCESS | 2310 | Values: 94.0 93.0 94.0 93.0 95.0 94.0 94.0 93.0 94.0 93.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:85.50 stddev:2.11 (2.5%) stddev-sans-first:2.22 13:38:06 INFO - PROCESS | 2310 | Values: 85.0 85.0 87.0 84.0 88.0 83.0 90.0 85.0 86.0 84.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.00 stddev:3.99 (7.5%) stddev-sans-first:4.23 13:38:06 INFO - PROCESS | 2310 | Values: 53.0 53.0 53.0 52.0 52.0 53.0 53.0 65.0 51.0 53.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.50 stddev:3.57 (5.2%) stddev-sans-first:3.09 13:38:06 INFO - PROCESS | 2310 | Values: 62.0 72.0 74.0 70.0 68.0 66.0 65.0 65.0 68.0 69.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 13:38:06 INFO - PROCESS | 2310 | Values: 82.0 81.0 81.0 83.0 82.0 81.0 82.0 84.0 83.0 82.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.50 stddev:10.06 (7.9%) stddev-sans-first:9.85 13:38:06 INFO - PROCESS | 2310 | Values: 137.0 111.0 141.0 126.0 126.0 127.0 132.0 128.0 123.0 109.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.50 Median:138.50 stddev:11.84 (8.6%) stddev-sans-first:12.25 13:38:06 INFO - PROCESS | 2310 | Values: 134.0 143.0 138.0 137.0 143.0 174.0 139.0 137.0 134.0 136.0 13:38:06 INFO - PROCESS | 2310 | 13:38:06 INFO - PROCESS | 2310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 13:38:06 INFO - PROCESS | 2310 | Values: 67.0 67.0 65.0 67.0 67.0 67.0 66.0 67.0 67.0 66.0 13:38:06 INFO - PROCESS | 2310 | -------- Summary: end -------- 13:38:06 INFO - PROCESS | 2310 | 13:38:07 INFO - TEST-INFO | 2310: exit 0 13:38:07 INFO - TEST-OK | kraken | took 56625ms 13:38:07 INFO - SUITE-END | took 1169s 13:38:07 INFO - Completed test suite (00:19:30) 13:38:07 INFO - Working with test: dromaeo_css 13:38:07 INFO - Generating results file: dromaeo_css 13:38:07 INFO - Working with test: kraken 13:38:07 INFO - Generating results file: kraken 13:38:07 INFO - javascript benchmark 13:38:07 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:38:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:38:07 INFO - process_Request line: dromaeo_css 7448.12 graph.html#tests=[[72,64,59]] 13:38:07 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:38:07 INFO - process_Request line: kraken 1423.30 graph.html#tests=[[232,64,59]] 13:38:07 INFO - RETURN: dromaeo_css: 7448.12 13:38:07 INFO - RETURN: kraken: 1423.30 13:38:07 INFO - javascript benchmark 13:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3402.0814380117367, 3458.2910503346807, 3466.9826650866726, 3481.56480439945, 3534.134137136402, 5588.832335029955, 5624.521915637166, 5656.547476201904, 5660.688662123582, 5682.062459694156, 4701.506341834101, 5541.0, 5583.5254003409755, 5718.342390625079, 5748.626339287944, 5057.544820966113, 5109.080365534193, 5112.437631860493, 5136.101182293102, 5198.896022079556, 5160.225966105096, 5200.661956972804, 5219.817306394277, 5220.138677118271, 5271.209318602202, 5065.138926382506, 5069.493050694938, 5154.768035438415, 5155.123628983082, 5201.271821944931, 5122.743862806882, 5132.153194722866, 5153.252778347156, 5153.742312884341, 5164.870878228036, 5076.543111120017, 5111.616628752859, 5116.820911268088, 5119.539241468286, 5128.179491281415, 5470.343558772933, 5491.039068163055, 5532.502074813246, 5534.972325138388, 5556.0, 6186.19579454668, 6219.782307619212, 6224.439800417938, 6232.376762323776, 6233.5013198944425, 6236.532260080512, 6272.372762723691, 6288.968555157241, 6309.305976342599, 6311.116443697886, 5623.690697011662, 5702.971485142548, 5741.425857414309, 5753.568482363798, 5797.420257974169, 6293.465055470337, 6334.049892516067, 6347.206599175103, 6347.777827776098, 6357.1735674362035, 6058.666773327421, 6085.726142323518, 6112.235970503687, 6124.755009799558, 6135.96932015346, 6105.542084343692, 6131.315499379051, 6168.845778855564, 6195.752169913243, 6230.937690623035, 6155.4767844732805, 6162.22972128484, 6168.92043892326, 6174.44430001302, 6176.505879529627, 6033.396660333931, 6213.906791398133, 6216.316205217422, 6223.906641400383, 6232.3144454110015, 4821.180399332052, 4835.20219163834, 4852.126617208936, 4884.413870335511, 4887.511248875155, 4359.825606975749, 4374.518802931675, 4406.427164468599, 4413.205622987893, 4427.889302767457, 5485.259489968883, 5583.525400341016, 5647.774089036392, 5661.688607126647, 5708.20085188074, 5927.2590926134235, 6123.25211838015, 6133.44798968095, 6185.165002724664, 6238.937610623926, 5605.243292155506, 5606.831795046155, 5626.746796394172, 5631.324241091095, 5635.6618602883955, 5261.421243663194, 5319.2021196820015, 5327.9733601331745, 5331.840044798662, 5348.224507446398, 6221.62670239769, 6321.7787377440645, 6322.462590679752, 6323.588966717149, 6369.235691717024, 6267.843303917439, 6284.591501552384, 6284.748610055546, 6294.748210071729, 6306.085617585516, 5285.233641122093, 6150.969245153746, 6293.842653933688, 6301.558890877594, 6311.431971122621, 5998.34018258, 6104.4505994460715, 6116.0, 6161.322254552086, 6167.105769663463, 6259.874802503833, 6278.0, 6279.466245369194, 6294.433500984934, 6317.526185536011, 5165.302684137743, 6055.061465472859, 6092.664903430354, 6111.083337499411, 6112.388761123852, 4616.353710480468, 5940.762369505172, 5984.910226346521, 6095.786647467317, 6097.0, 5808.970955145197, 5831.679257640871, 5879.882402352015, 5886.117082437498, 5899.0, 5875.41245875409, 6036.577439579188, 6063.727132279147, 6070.666113363631, 6123.938760612336, 5869.119632055055, 5885.852853678521, 5949.8215053548465, 5971.731272092853, 6011.549133814894], "unit": "score", "name": "dojo.html", "value": 5641.475756332906}, {"lowerIsBetter": false, "replicates": [454.8135264541539, 470.3931927813121, 533.6397931396308, 539.1212323912023, 558.265880367317, 21806.781932180675, 29368.0, 29402.85298573507, 29431.0, 29482.705172948263, 38428.42357364642, 39291.0177245569, 39309.01727456815, 39374.80312598433, 39422.80288598553, 9527.857082143755, 9716.174125199366, 9725.416475011521, 9729.70810875675, 9733.2213422926, 9496.66761663342, 9641.42151470914, 9642.903570964305, 9644.0, 9668.806623867553, 9617.519124043805, 9682.56428460721, 9685.32202745808, 9686.32195746298, 9687.128158465737, 9555.474448905308, 9658.3722058066, 9659.565319560566, 9678.032196780336, 9688.418694878295, 8597.914020859836, 9358.812823743556, 9443.480608566526, 9675.70972870815, 9696.563654635558, 39183.60816391828, 39678.80160599208, 39739.60260397388, 39771.60228397708, 39837.80486585407, 3306.024722706783, 3362.411577973869, 3375.1899544109483, 3438.638942911008, 3561.8397172127316, 28223.435531289466, 28481.0, 28708.138755837357, 28724.0, 29271.0, 2734.617153598478, 2780.7775377969715, 2860.7139286071433, 2983.8209707417623, 2985.089547687954, 466116.66941665416, 467083.0, 467384.0, 470755.0, 471293.99999999657, 47980.0, 51788.223176652384, 52936.735316323175, 60052.69973650104, 60976.39023609707, 60021.399786002454, 60169.0, 60660.0, 60734.08898866521, 60756.0, 16055.759163612554, 16238.837611623969, 16251.59371015734, 16304.51086467384, 16336.75494867578, 11370.97661210495, 11538.480768365444, 12271.202371845802, 12390.690232744253, 12404.25574465535, 18198.818011819978, 18202.54493637643, 18215.362462313755, 18221.18004689792, 18299.359522416653, 8040.195980401913, 8230.09468958414, 8232.62953167109, 8250.504969701837, 8282.751517454486, 929.846575315079, 940.8165407745424, 1039.2361614213546, 1086.1907878630313, 1196.3180986837592, 29468.705312946597, 29549.556756648668, 30510.0, 30592.27895392279, 30628.69371306303, 1063.2450959818616, 1110.3948348150116, 1141.9950443609737, 1142.6115120858947, 1187.976240475203, 13854.991026301332, 14016.772975429947, 14150.504732334319, 14239.288035598385, 14253.572392828231, 540176.0, 542540.0, 545834.0, 547926.0, 549347.0, 52585.0, 52916.73541632267, 52929.47070529246, 52951.73524132355, 52995.20507192395, 1405.3605609447677, 1407.6551244945053, 1430.2991534147984, 1433.3908089062106, 1434.6556826361598, 24838.50322993566, 26172.0, 27271.909123634832, 27334.589981150697, 28076.85961570179, 47620.76189619168, 47966.76016619895, 47989.280160796916, 48082.0, 48118.51881481281, 481310.0, 503803.0, 539014.0, 539290.0, 543541.0, 28860.0, 29048.419031619673, 29186.0, 29214.561781573717, 29288.828446861888, 40009.599904000585, 41624.16751664889, 41755.7912210437, 41813.74558763242, 42168.78915605402, 34142.487862681584, 34840.82579587086, 35397.82301088478, 35715.82142089273, 35893.82053089718, 34249.48625770665, 35027.649723502436, 35259.82370088133, 35342.11644708903, 35405.46891796677, 35009.62379702537, 35270.47094293639, 35272.11819704528, 35393.646063540065, 35893.0, 29472.410551788416, 30505.0, 30506.0, 30628.0, 30676.84661576678, 23596.410089747893, 23997.760022400253, 24037.75962240425, 24523.0, 24575.262742117764], "unit": "score", "name": "ext.html", "value": 19058.527291953284}, {"lowerIsBetter": false, "replicates": [358.546438754975, 364.29327105415507, 368.13855577947606, 368.6921420613787, 370.8701954315988, 13243.933780331108, 14391.352389142488, 15187.77218341723, 19009.809901900975, 19916.99999999998, 19759.0, 19984.400467985983, 20481.385558433234, 20871.47821304468, 20892.477688057766, 6338.239411270631, 6562.507811914102, 6576.572522786028, 6582.802515924506, 6589.703463344137, 4539.659525535581, 4619.653525985547, 4751.574527641711, 6534.281229064799, 7055.85888282234, 7028.191757947825, 7292.708291668353, 7300.868365403371, 7339.706411743524, 7341.669624866894, 6980.616066116361, 7205.135383753931, 7254.165770936357, 7259.528130671516, 7271.999999999974, 6794.592324460548, 6863.691133898987, 6874.690638921261, 6884.311568843125, 6885.0, 21470.033848476854, 23989.760102398926, 24468.26595202147, 25235.62146567803, 25551.85016674254, 2202.25123458025, 2442.8778561072054, 2449.9387515312083, 2455.1161581830706, 2479.5784716598223, 14690.632734181625, 15092.924535377253, 15200.16399098049, 15352.232388380648, 15714.842851571453, 1852.6202128563748, 1884.8586356023352, 1930.1217945834612, 1955.9706604400944, 1982.900854957261, 82683.17316826814, 84573.57713211395, 86518.0, 86848.13151868463, 87138.28617138299, 10531.315464494783, 10828.837567436494, 10966.616168434066, 10978.517900083547, 11051.502682379312, 13034.152780069455, 13155.67110822218, 13161.210327380388, 13162.078654494093, 13177.538786142632, 8219.54792486419, 8261.339092872557, 8265.586720663943, 8345.54099524532, 8388.203120703523, 8506.447080939843, 8508.149185081442, 8514.403991720521, 8614.784630384165, 8622.223999840044, 4025.4766880305374, 4164.75011499311, 4364.5635436456105, 4448.021435284232, 4501.0, 1792.211426972128, 1847.5011746828282, 1850.1859181959894, 1854.3880519428556, 1855.7587513623143, 871.4205053639386, 921.4149015375285, 940.7695114696807, 1001.4892404873567, 1060.5121644043672, 16081.195940202942, 16880.240389182516, 17406.738898916527, 18180.36368727088, 20334.796652033292, 817.6198067898337, 917.687986084721, 936.9203617692573, 970.8883478400074, 971.1114330387617, 8731.0, 10379.06588407047, 10691.889893220921, 10722.52228866942, 10865.005119844125, 728254.0, 728858.0, 736800.0, 742827.0, 749714.0, 104165.0, 105167.0, 105425.0, 107369.46315268373, 109835.0, 1055.773008803111, 1080.1790639114329, 1103.6027030269097, 1105.618561596248, 1112.57165991094, 16787.496375108767, 17703.760736748303, 17730.36527511831, 17740.379086731904, 18015.459536213933, 48994.26508602303, 49681.0, 49739.0, 50199.74900125476, 51774.223386648475, 64871.0, 67319.0, 67463.32536674767, 67847.0, 68001.65999169972, 7604.80987975305, 7750.883736743841, 7803.375729941477, 7804.6878124874365, 7822.0, 11184.161187911102, 11229.494672739584, 11792.70518237051, 11916.880831191924, 12266.877331226931, 10199.0820826126, 10358.741031474274, 10507.15942724565, 10548.314359566604, 10679.839802403125, 7181.928180718335, 10022.09359285799, 10048.09567138961, 10335.896641033794, 10502.159827213653, 9639.373440726331, 9853.507324633883, 10344.741381465523, 10491.370517768959, 10755.247132700635, 7492.40060795146, 7553.546787192786, 7644.923550764421, 7673.0, 7699.8075048122, 8275.296599788844, 10405.739856503647, 10622.36265824053, 10630.149588032784, 10660.200484963814], "unit": "score", "name": "jquery.html", "value": 9400.777486061002}, {"lowerIsBetter": false, "replicates": [1342.3892129081269, 1503.4286970951039, 1532.7011232809602, 1767.4874286456927, 1943.7278780970667, 7916.802079947997, 8109.107998120202, 8117.228863257981, 8129.146439623828, 8132.349412047037, 8419.536925469096, 8531.123152906366, 8650.480971141737, 8657.69698060568, 8666.696665616704, 2424.5999410097356, 2488.1167185649015, 2493.750624937501, 2493.987530062347, 2496.5256601245796, 2150.63439215333, 2211.966820497694, 2214.2250212425683, 2217.2018073493527, 2426.162973774054, 2155.5473350596394, 2394.0, 2442.743511931248, 2443.8778061096964, 2451.191106934716, 2399.148302352657, 2429.8299119061585, 2431.3921519620094, 2459.1638842793536, 2466.6176742604925, 2132.3816093332916, 2200.9559808803733, 2399.4121440247077, 2456.1403508771964, 2469.1111199967995, 8570.957145214297, 8655.350848686374, 8669.0, 8674.436161649473, 8699.60851761666, 5300.787968481256, 5441.945580544223, 5445.727713614304, 5447.073997420448, 5450.754716037788, 3592.0, 3681.834317455721, 3746.38184699527, 3764.9435258471144, 3765.246950609889, 1046.2414749306768, 1063.7287491689647, 1070.0797314309686, 1101.0750969185842, 1102.0522350778324, 12182.208156469802, 12213.572524961584, 12218.20581662189, 12232.388380580935, 12233.143679942408, 4877.5366340197625, 4899.387576552931, 4975.353204083518, 4990.675606085593, 4994.2508623706735, 10203.38779673222, 10207.387556746618, 10221.488925553842, 10225.693229203136, 10245.0, 5507.834764957058, 5511.173324001432, 5519.420460851553, 5521.806736764194, 5528.834134975958, 4918.0901533216465, 4926.9014619707405, 4986.650934434628, 5004.724740139327, 5009.974950125299, 3919.7648141111627, 3968.8214030368704, 3969.80150992455, 3997.140614767839, 4013.5986401359633, 1302.947882084706, 1313.4680454415977, 1319.9472021119047, 1328.913620614657, 1330.9267990260628, 1086.3481910853582, 1100.5762781329086, 1231.4889320931893, 1292.0761655416422, 1303.328785675378, 8230.382721295926, 8237.629306681214, 8248.793780155424, 8261.17388261181, 8264.132266112092, 508.14056917641045, 517.9378474583074, 521.0516859316009, 521.8695326168458, 522.0941666209125, 5875.148103525051, 5968.970155149196, 5978.1929439525975, 6034.2155519782145, 6184.319724830265, 9538.093881081286, 10622.787544249071, 10772.407517586607, 10780.568777248978, 10785.514651840685, 10283.794324113625, 10613.84079238812, 10638.574457021787, 10657.094146997437, 10690.839637405445, 8009.718445048764, 8220.972378452694, 8343.207395297437, 8365.8326833463, 8434.114417986024, 7287.27127287267, 7822.491538050009, 8073.717419890276, 8105.513669179868, 8130.715424960098, 9459.148676618863, 9459.195968342769, 9536.284778641768, 9539.761505962406, 9682.951585242028, 9563.569639366106, 9973.152282056106, 9987.151092156957, 10035.297529172887, 10080.54637541327, 7367.373773229336, 7449.404047676281, 7481.551106933602, 7576.583287919218, 7584.08990921093, 6238.781642642486, 8274.793130171553, 8279.917200828155, 8286.875696864672, 8289.958550207451, 7779.883301750365, 7855.0, 7885.132635409986, 8021.799455013671, 8033.477823941425, 7704.8073798153255, 7715.729949451742, 7739.651715672696, 7821.843563128819, 7854.136045035156, 7896.368290536629, 7967.2431119043595, 7967.402444816546, 7970.442069055111, 7974.362051036019, 7073.540219885691, 7133.607651579213, 7137.785866424016, 7168.856622867618, 7193.280671932974, 6476.319986401549, 6641.236257830411, 7005.369516743517, 7255.56466612005, 7335.376492998155], "unit": "score", "name": "mootools.html", "value": 4832.450539784529}, {"lowerIsBetter": false, "replicates": [316.5584010305624, 323.3774983157421, 328.7945034353529, 330.57851239669435, 335.37285276532884, 6641.335866413357, 6648.534602577809, 6658.9001164982565, 6664.600123992564, 6687.86624267515, 6314.305426403092, 6489.156409666737, 6520.836979075525, 6525.151730275057, 6590.439812615933, 3961.861334853281, 4846.927296090562, 4874.439439464454, 4884.902301953959, 4894.755262236892, 4623.4451865776155, 4873.0, 4898.24077268024, 4898.412190537123, 4902.994886048352, 4674.626029917598, 4694.460137084245, 4763.14263432582, 4771.570558649721, 4777.713337199762, 4761.59526440253, 4763.904721905577, 4778.378810754597, 4796.952030479685, 4797.9760101199445, 4127.7936103194725, 4127.894773665422, 4129.070959034223, 4136.9793151034355, 4137.834486620532, 6154.63072215664, 6370.299267080617, 6383.234011918553, 6383.840403989938, 6433.163688720483, 5720.0, 5722.313322401297, 5730.856728581777, 5737.627054241461, 5738.024535828878, 7014.929850701478, 7027.718891244344, 7029.613371264579, 7042.894356584656, 7060.470464715116, 4651.302304654295, 4669.4630117536235, 4677.602403795681, 4681.438227412698, 4689.742064186468, 6627.469802415795, 6853.862922741567, 7100.28997100291, 7439.181690014094, 7467.850642987164, 4558.817647294071, 4593.931091033637, 4600.88497787558, 4606.470255920545, 4614.838480653161, 4671.6262698984, 4671.948811517449, 4686.81252749893, 4695.647826413033, 4696.9060618787435, 5439.456054394529, 5603.047481928082, 5603.831885043455, 5609.411011843697, 5625.128105143709, 5735.627184233012, 7102.18324892644, 7113.3953613943395, 7121.394681452135, 7127.501074924706, 1604.9117298548458, 1617.7573363995496, 1625.5936015996, 1626.5608285762778, 1626.7397216445313, 1019.3781793106348, 1026.6663334416344, 1036.8341065429645, 1043.3635482355758, 1051.6371851711147, 5732.111522713986, 6234.1583886174785, 6579.276279609239, 6586.176727909012, 6593.241777195684, 7095.325944035309, 7185.820354491075, 7359.153697324769, 7383.335499805044, 7449.366803821736, 5686.943130568724, 6000.639961602318, 6472.838179045561, 6526.34736526353, 6548.967255163789, 3861.092643228839, 3879.18537107205, 3891.2217556488818, 3903.687704983651, 3911.6088391161225, 7427.925720742724, 7717.305442510201, 7724.92275077242, 7744.6514906829325, 7751.689932402641, 7626.275503827128, 7633.847323053619, 7636.541807491568, 7636.694532218649, 7644.770656880302, 6276.497880169484, 7719.680537368873, 7732.149463559116, 7734.883976740353, 7757.0, 7128.28717128283, 7392.926070739224, 7399.112106547249, 7402.0, 7410.147832999274, 7262.96368518154, 7275.272472752894, 7279.053723015974, 7280.126384833854, 7288.380487658608, 5996.610220335664, 7488.213737557478, 7705.460617756703, 7722.53664780115, 7741.45809793309, 4492.618127459072, 4612.654050946259, 4625.329327247463, 4627.375304333872, 4629.236176031052, 7345.228750981284, 7345.742898998509, 7359.0, 7366.705331786883, 7369.299916507923, 6860.211075726355, 7082.0793296873135, 7092.5389849659605, 7097.645117744195, 7125.67934442941, 7052.224255332012, 7120.608366539683, 7126.394256488256, 7130.7147714092935, 7133.286671332825, 6922.619255940972, 6930.48021398387, 6936.653167341512, 6949.409300209539, 6960.0, 6909.205441374306, 7083.82290442743, 7089.82275443118, 7091.858162836611, 7101.041359416413, 5603.551715862803, 6689.832754181184, 6946.722131114699, 6959.89560156588, 6960.4779641526075], "unit": "score", "name": "prototype.html", "value": 5132.316120404358}, {"lowerIsBetter": false, "replicates": [650.3561474140596, 651.7458191305388, 675.1762849323825, 714.6176795414455, 751.1099347273481, 14483.493077742281, 14700.0, 14709.411623535047, 14723.558293251219, 14727.48453804117, 12533.749325013494, 13217.735645287088, 13331.400086996084, 13346.66633334167, 13383.263920484369, 864.4726716702822, 881.3081730841259, 882.7528292078229, 886.0740526150156, 886.9645214191424, 880.058337578791, 884.0143240287098, 884.3411658314565, 887.8890138732659, 888.471359541072, 922.1654402765508, 927.8469052606312, 928.6610387208688, 929.7815013471828, 934.4953724988499, 918.361738591679, 921.3688623293066, 923.0723123261113, 928.6192661008954, 928.9349745517817, 687.3573209049555, 688.6246995387526, 688.9104416425882, 688.9207741109786, 691.7820886420811, 12474.81287780684, 12500.437480313407, 12509.937450312782, 12511.499540018389, 12543.310117943509, 11161.665150045512, 11181.776364472666, 11241.437928103562, 11308.604198853001, 11320.6037788677, 9404.62381504739, 9529.714108576754, 9545.52272386378, 9585.520723963775, 9628.951855240679, 3415.487676848493, 3459.3427248822645, 3460.0311912664242, 3465.740069494773, 3469.8785542506143, 59826.50433739148, 75345.0, 78813.0, 78931.0, 79755.6012219941, 7797.7660670179985, 9491.335606507479, 9589.184919281799, 10007.699769006942, 10206.795864082826, 20602.175912963612, 20942.057607407703, 20971.8951405242, 20987.0, 21002.0, 7409.666565004588, 7653.693852245848, 7673.194314596999, 7717.382609391235, 7803.80490487731, 4097.426360309559, 4141.171765646883, 4153.003279212967, 4171.749695018309, 4173.707840451139, 3407.1993081625797, 3465.740069494798, 3469.8612055517497, 3472.7048200903205, 3476.461148521983, 615.2002396884122, 627.5450298533526, 627.5575719118011, 647.064991087883, 648.011782032395, 582.484501216418, 606.6966516741629, 627.2253766598247, 630.5838146823074, 642.9357064293627, 8127.878081828777, 8547.529885856213, 8661.653533858575, 8857.0, 8920.955395222982, 527.7044854881278, 572.2074926227123, 594.521410264741, 600.7296716477603, 603.1405247522263, 3868.361720316116, 3923.705722070856, 4035.9798201008807, 4070.1859628074503, 4185.330347144442, 88643.67034494488, 90041.54979225193, 90138.09861901429, 96628.51685741526, 97873.0, 59891.0, 72366.27633723701, 76196.0, 76212.61893690495, 81169.18830811616, 70906.64546677233, 71012.2898771016, 71349.6432517834, 72161.63919180476, 72619.0, 8039.356851451753, 8189.631466584137, 8383.496990180609, 9038.231750301298, 9081.137291957253, 49020.2646960303, 50609.49390506195, 51522.48477515177, 52435.73782131065, 52796.47203528069, 61541.69229153825, 66347.67304653784, 72958.54082918206, 73057.63471182823, 74584.62707686427, 10099.848502272325, 11050.668479945614, 11053.723656908642, 11137.777244455228, 11355.261907975955, 11112.77759446444, 12121.15151939391, 12310.446029928495, 12384.75230495367, 12503.437345319664, 11133.83299250528, 11613.883861161617, 11851.881481185077, 12026.939865300617, 12327.815082773945, 9078.682246121354, 11821.645350639494, 11930.105242106703, 11945.0, 12228.02175825914, 10540.841887371542, 11146.442677866236, 11362.431878406212, 11735.119866009913, 11771.823422648496, 9414.105659962293, 9424.198943089914, 9524.285678573997, 9579.856302155613, 10320.071193592612, 8997.415168014059, 9153.633854646007, 9239.353245272767, 9625.374350667184, 10074.647387341407], "unit": "score", "name": "yui.html", "value": 6809.545061731653}], "name": "dromaeo_css", "value": 7448.1175182017305}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 111.0, 111.0, 110.0, 110.0, 118.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [158.0, 118.0, 147.0, 156.0, 121.0, 140.0, 140.0, 119.0, 162.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.0}, {"lowerIsBetter": true, "replicates": [184.0, 195.0, 186.0, 183.0, 185.0, 194.0, 263.0, 187.0, 188.0, 184.0], "unit": "score", "name": "audio-dft", "value": 194.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 85.0, 79.0, 56.0, 62.0, 57.0, 83.0, 85.0, 83.0], "unit": "score", "name": "audio-fft", "value": 73.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 126.0, 79.0, 78.0, 82.0, 114.0, 77.0, 103.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 99.6}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 86.0, 92.0, 88.0, 91.0, 84.0, 92.0, 86.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.7}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 94.0, 93.0, 95.0, 94.0, 94.0, 93.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 84.0, 88.0, 83.0, 90.0, 85.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [53.0, 53.0, 53.0, 52.0, 52.0, 53.0, 53.0, 65.0, 51.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [62.0, 72.0, 74.0, 70.0, 68.0, 66.0, 65.0, 65.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 81.0, 83.0, 82.0, 81.0, 82.0, 84.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [137.0, 111.0, 141.0, 126.0, 126.0, 127.0, 132.0, 128.0, 123.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [134.0, 143.0, 138.0, 137.0, 143.0, 174.0, 139.0, 137.0, 134.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 65.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1423.3}]} 13:38:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1423.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7448.12"}}} 13:38:07 INFO - Return code: 0 13:38:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:38:07 INFO - # TBPL SUCCESS # 13:38:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:38:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:38:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:38:07 INFO - 2016-02-10 13:38:07.899 screenresolution[2314:17278] starting screenresolution argv=screenresolution get 13:38:07 INFO - 2016-02-10 13:38:07.902 screenresolution[2314:17278] Display 0: 1600x1200x32@60 13:38:07 INFO - 2016-02-10 13:38:07.908 screenresolution[2315:17281] starting screenresolution argv=screenresolution list 13:38:07 INFO - Available Modes on Display 0 13:38:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:38:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:38:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:38:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:38:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:38:08 INFO - Intel Iris: 13:38:08 INFO - Chipset Model: Intel Iris 13:38:08 INFO - Type: GPU 13:38:08 INFO - Bus: Built-In 13:38:08 INFO - VRAM (Dynamic, Max): 1536 MB 13:38:08 INFO - Vendor: Intel (0x8086) 13:38:08 INFO - Device ID: 0x0a2e 13:38:08 INFO - Revision ID: 0x0009 13:38:08 INFO - Displays: 13:38:08 INFO - Display: 13:38:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:38:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:38:08 INFO - Display Serial Number: 1600x1200 60 13:38:08 INFO - Main Display: Yes 13:38:08 INFO - Mirror: Off 13:38:08 INFO - Online: Yes 13:38:08 INFO - Rotation: Supported 13:38:08 INFO - Return code: 0 13:38:08 INFO - Running post-action listener: _resource_record_post_action 13:38:08 INFO - Running post-run listener: _resource_record_post_run 13:38:09 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 466944; Write bytes: 709995008; Read time: 6; Write time: 2033 13:38:09 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403653120; Write bytes: 406519296; Read time: 30225; Write time: 754 13:38:09 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 466944; Write bytes: 301853696; Read time: 6; Write time: 1273 13:38:09 INFO - Running post-run listener: _upload_blobber_files 13:38:09 INFO - Blob upload gear active. 13:38:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:38:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:38:09 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:10 INFO - (blobuploader) - INFO - Done attempting. 13:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:38:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:11 INFO - (blobuploader) - INFO - Done attempting. 13:38:11 INFO - (blobuploader) - INFO - Iteration through files over. 13:38:11 INFO - Return code: 0 13:38:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:38:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:38:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e12207f4cfa613a57c28efce9d0c772a948613a550463847836256e2d0708fc03d4ab73006f488cc17fe90aff668eaf417d82484ec07c261f03f32c7ec6da875", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e16eef84d7d1796dd33161f74bf010372604e97a36fe09dbce954f472ba590e3cfd3e9afe2e39c74c042834c3eb4e9fbb022773e5eff29cdddd6eb85dbcc982e"} 13:38:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:38:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:38:11 INFO - Contents: 13:38:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e12207f4cfa613a57c28efce9d0c772a948613a550463847836256e2d0708fc03d4ab73006f488cc17fe90aff668eaf417d82484ec07c261f03f32c7ec6da875", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e16eef84d7d1796dd33161f74bf010372604e97a36fe09dbce954f472ba590e3cfd3e9afe2e39c74c042834c3eb4e9fbb022773e5eff29cdddd6eb85dbcc982e"} 13:38:11 INFO - Running post-run listener: copy_logs_to_upload_dir 13:38:11 INFO - Copying logs to upload dir... 13:38:11 INFO - mkdir: /builds/slave/test/build/upload/logs 13:38:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.244279 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-02-10 13:38:11.589674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 13:38:11.592871) ========= 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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e12207f4cfa613a57c28efce9d0c772a948613a550463847836256e2d0708fc03d4ab73006f488cc17fe90aff668eaf417d82484ec07c261f03f32c7ec6da875", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e16eef84d7d1796dd33161f74bf010372604e97a36fe09dbce954f472ba590e3cfd3e9afe2e39c74c042834c3eb4e9fbb022773e5eff29cdddd6eb85dbcc982e"} build_url:https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/WiOriGWPSpuTaeIxuopY-w/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/e12207f4cfa613a57c28efce9d0c772a948613a550463847836256e2d0708fc03d4ab73006f488cc17fe90aff668eaf417d82484ec07c261f03f32c7ec6da875", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e16eef84d7d1796dd33161f74bf010372604e97a36fe09dbce954f472ba590e3cfd3e9afe2e39c74c042834c3eb4e9fbb022773e5eff29cdddd6eb85dbcc982e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 13:38:11.619381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 13:38:11.619726) ========= 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.cNf2RTzU9t/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.TcJwOITVWZ/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004822 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 13:38:11.668366) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 13:38:11.668714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 13:38:11.669127) ========= ========= Total master_lag: 2.72 =========