builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0029 starttime: 1456435278.36 results: success (0) buildid: 20160225113726 builduid: c65f48eb228e4669a51e2e34c5ae9319 revision: ad4d966f23677027aa0bd08f195f1478dd9d6d8c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.358092) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.358505) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.358794) ========= 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.cuMvAH4rqt/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.brjdGkRrDr/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.005617 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.390851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.391182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.421396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.421813) ========= 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.cuMvAH4rqt/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.brjdGkRrDr/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.005279 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.472327) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.472750) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.473339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.473618) ========= 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.cuMvAH4rqt/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.brjdGkRrDr/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-25 13:21:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.19M=0.001s 2016-02-25 13:21:18 (8.19 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179247 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.911582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.911935) ========= 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.cuMvAH4rqt/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.brjdGkRrDr/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.019776 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:18.947203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-25 13:21:18.947539) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad4d966f23677027aa0bd08f195f1478dd9d6d8c --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 ad4d966f23677027aa0bd08f195f1478dd9d6d8c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cuMvAH4rqt/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.brjdGkRrDr/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-25 13:21:19,015 truncating revision to first 12 chars 2016-02-25 13:21:19,015 Setting DEBUG logging. 2016-02-25 13:21:19,015 attempt 1/10 2016-02-25 13:21:19,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad4d966f2367?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 13:21:21,209 unpacking tar archive at: fx-team-ad4d966f2367/testing/mozharness/ program finished with exit code 0 elapsedTime=2.429521 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-25 13:21:21.470238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:21.470570) ========= echo ad4d966f23677027aa0bd08f195f1478dd9d6d8c in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ad4d966f23677027aa0bd08f195f1478dd9d6d8c'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cuMvAH4rqt/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.brjdGkRrDr/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 ad4d966f23677027aa0bd08f195f1478dd9d6d8c program finished with exit code 0 elapsedTime=0.005093 script_repo_revision: 'ad4d966f23677027aa0bd08f195f1478dd9d6d8c' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:21.491638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:21.491918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 13:21:21.504405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-25 13:21:21.504671) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.cuMvAH4rqt/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.brjdGkRrDr/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:21:21 INFO - MultiFileLogger online at 20160225 13:21:21 in /builds/slave/test 13:21:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:21:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:21:21 INFO - {'append_to_log': False, 13:21:21 INFO - 'base_work_dir': '/builds/slave/test', 13:21:21 INFO - 'blob_upload_branch': 'Fx-Team', 13:21:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:21:21 INFO - 'branch': 'Fx-Team', 13:21:21 INFO - 'buildbot_json_path': 'buildprops.json', 13:21:21 INFO - 'config_files': ('talos/mac_config.py',), 13:21:21 INFO - 'default_actions': ('clobber', 13:21:21 INFO - 'read-buildbot-config', 13:21:21 INFO - 'download-and-extract', 13:21:21 INFO - 'populate-webroot', 13:21:21 INFO - 'create-virtualenv', 13:21:21 INFO - 'install', 13:21:21 INFO - 'run-tests'), 13:21:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:21:21 INFO - 'download_minidump_stackwalk': True, 13:21:21 INFO - 'download_symbols': 'ondemand', 13:21:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:21:21 INFO - 'tooltool.py': '/tools/tooltool.py', 13:21:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:21:21 INFO - '/tools/misc-python/virtualenv.py')}, 13:21:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:21:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:21:21 INFO - 'installer_path': 'installer.exe', 13:21:21 INFO - 'log_level': 'info', 13:21:21 INFO - 'log_name': 'talos', 13:21:21 INFO - 'log_to_console': True, 13:21:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:21:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:21:21 INFO - 'opt_config_files': (), 13:21:21 INFO - 'pip_index': False, 13:21:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:21:21 INFO - 'cmd': ('bash', 13:21:21 INFO - '-c', 13:21:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:21:21 INFO - 'enabled': True, 13:21:21 INFO - 'halt_on_failure': False, 13:21:21 INFO - 'name': 'check_screen_resolution'},), 13:21:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:21:21 INFO - 'cmd': ('bash', 13:21:21 INFO - '-c', 13:21:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:21:21 INFO - 'enabled': True, 13:21:21 INFO - 'halt_on_failure': False, 13:21:21 INFO - 'name': 'check_screen_resolution'},), 13:21:21 INFO - 'run_cmd_checks_enabled': True, 13:21:21 INFO - 'sps_profile': False, 13:21:21 INFO - 'sps_profile_interval': 0, 13:21:21 INFO - 'suite': 'dromaeojs-e10s', 13:21:21 INFO - 'system_bits': '32', 13:21:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:21:21 INFO - 'title': 't-yosemite-r7-0029', 13:21:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:21:21 INFO - 'use_talos_json': True, 13:21:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:21:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:21:21 INFO - 'work_dir': 'build'} 13:21:21 INFO - ##### 13:21:21 INFO - ##### Running clobber step. 13:21:21 INFO - ##### 13:21:21 INFO - Running pre-action listener: _resource_record_pre_action 13:21:21 INFO - Running main action method: clobber 13:21:21 INFO - rmtree: /builds/slave/test/build 13:21:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:21:23 INFO - Running post-action listener: _resource_record_post_action 13:21:23 INFO - ##### 13:21:23 INFO - ##### Running read-buildbot-config step. 13:21:23 INFO - ##### 13:21:23 INFO - Running pre-action listener: _resource_record_pre_action 13:21:23 INFO - Running main action method: read_buildbot_config 13:21:23 INFO - Using buildbot properties: 13:21:23 INFO - { 13:21:23 INFO - "project": "", 13:21:23 INFO - "product": "firefox", 13:21:23 INFO - "script_repo_revision": "production", 13:21:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:21:23 INFO - "repository": "", 13:21:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:21:23 INFO - "buildid": "20160225113726", 13:21:23 INFO - "pgo_build": "False", 13:21:23 INFO - "basedir": "/builds/slave/test", 13:21:23 INFO - "buildnumber": 516, 13:21:23 INFO - "slavename": "t-yosemite-r7-0029", 13:21:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:21:23 INFO - "platform": "yosemite_r7", 13:21:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:21:23 INFO - "branch": "fx-team", 13:21:23 INFO - "repo_path": "integration/fx-team", 13:21:23 INFO - "revision": "ad4d966f23677027aa0bd08f195f1478dd9d6d8c", 13:21:23 INFO - "stage_platform": "macosx64", 13:21:23 INFO - "builduid": "c65f48eb228e4669a51e2e34c5ae9319", 13:21:23 INFO - "slavebuilddir": "test" 13:21:23 INFO - } 13:21:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 13:21:23 INFO - Running post-action listener: _resource_record_post_action 13:21:23 INFO - ##### 13:21:23 INFO - ##### Running download-and-extract step. 13:21:23 INFO - ##### 13:21:23 INFO - Running pre-action listener: _resource_record_pre_action 13:21:23 INFO - Running main action method: download_and_extract 13:21:23 INFO - mkdir: /builds/slave/test/build/tests 13:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:23 INFO - https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/test_packages.json 13:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/test_packages.json 13:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:21:26 INFO - Downloaded 1277 bytes. 13:21:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:21:26 INFO - Using the following test package requirements: 13:21:26 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:21:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:21:26 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 13:21:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:21:26 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 13:21:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:21:26 INFO - u'jsshell-mac.zip'], 13:21:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:21:26 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 13:21:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:21:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:21:26 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 13:21:26 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:21:26 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 13:21:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:21:26 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 13:21:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:21:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:21:26 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 13:21:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:26 INFO - https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/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:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/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:21:27 INFO - Downloaded 17829768 bytes. 13:21:27 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:21:27 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:21:30 INFO - Return code: 0 13:21:30 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:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:30 INFO - https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:21:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:21:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:21:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/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:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/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:21:31 INFO - Downloaded 17829768 bytes. 13:21:31 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:21:31 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:21:35 INFO - Return code: 0 13:21: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:21:35 INFO - https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:21:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:21:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:21:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/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:21:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/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:21:36 INFO - Downloaded 10713410 bytes. 13:21:36 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:21:36 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:21:36 INFO - Return code: 0 13:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:36 INFO - https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:21:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:21:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:21:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 13:21:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0NHUyzmQUCGkcMjTljokA/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:21:39 INFO - Downloaded 111447038 bytes. 13:21:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:21:39 INFO - mkdir: /builds/slave/test/properties 13:21:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:21:39 INFO - Writing to file /builds/slave/test/properties/build_url 13:21:39 INFO - Contents: 13:21:39 INFO - build_url:https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:21:40 INFO - Running post-action listener: _resource_record_post_action 13:21:40 INFO - Running post-action listener: set_extra_try_arguments 13:21:40 INFO - ##### 13:21:40 INFO - ##### Running populate-webroot step. 13:21:40 INFO - ##### 13:21:40 INFO - Running pre-action listener: _resource_record_pre_action 13:21:40 INFO - Running main action method: populate_webroot 13:21:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:21:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:21:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:21:40 INFO - '--tppagecycles', 13:21:40 INFO - '7'], 13:21:40 INFO - 'tests': ['tsvgm']}}, 13:21:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:21:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:21:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:21:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:21:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:40 INFO - 'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:40 INFO - 'tests': ['damp', 'tps']}, 13:21:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:40 INFO - 'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['damp', 'tps']}, 13:21:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:21:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:21:40 INFO - 'other': {'tests': ['a11yr', 13:21:40 INFO - 'ts_paint', 13:21:40 INFO - 'tpaint', 13:21:40 INFO - 'sessionrestore', 13:21:40 INFO - 'sessionrestore_no_auto_restore']}, 13:21:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['a11yr', 13:21:40 INFO - 'ts_paint', 13:21:40 INFO - 'tpaint', 13:21:40 INFO - 'sessionrestore', 13:21:40 INFO - 'sessionrestore_no_auto_restore']}, 13:21:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['a11yr', 13:21:40 INFO - 'ts_paint', 13:21:40 INFO - 'tpaint', 13:21:40 INFO - 'sessionrestore', 13:21:40 INFO - 'sessionrestore_no_auto_restore']}, 13:21:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['a11yr', 13:21:40 INFO - 'ts_paint', 13:21:40 INFO - 'tpaint', 13:21:40 INFO - 'sessionrestore', 13:21:40 INFO - 'sessionrestore_no_auto_restore']}, 13:21:40 INFO - 'other_l64': {'tests': ['a11yr', 13:21:40 INFO - 'ts_paint', 13:21:40 INFO - 'tpaint', 13:21:40 INFO - 'sessionrestore', 13:21:40 INFO - 'sessionrestore_no_auto_restore']}, 13:21:40 INFO - 'other_nol64': {'tests': ['a11yr', 13:21:40 INFO - 'ts_paint', 13:21:40 INFO - 'tpaint', 13:21:40 INFO - 'sessionrestore', 13:21:40 INFO - 'sessionrestore_no_auto_restore']}, 13:21:40 INFO - 'svgr': {'tests': ['tsvgx', 13:21:40 INFO - 'tsvgr_opacity', 13:21:40 INFO - 'tart', 13:21:40 INFO - 'tscrollx', 13:21:40 INFO - 'cart']}, 13:21:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['tsvgx', 13:21:40 INFO - 'tsvgr_opacity', 13:21:40 INFO - 'tart', 13:21:40 INFO - 'tscrollx', 13:21:40 INFO - 'cart']}, 13:21:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:40 INFO - 'tests': ['tp5o']}, 13:21:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:40 INFO - 'talos_options': ['--e10s'], 13:21:40 INFO - 'tests': ['tp5o']}, 13:21:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:40 INFO - 'talos_options': ['--xperf_path', 13:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:40 INFO - 'tests': ['tp5n']}, 13:21:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:40 INFO - 'talos_options': ['--e10s', 13:21:40 INFO - '--xperf_path', 13:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:40 INFO - 'tests': ['tp5n']}}, 13:21:40 INFO - 'talos.zip': {'path': '', 13:21:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:21:40 INFO - Running post-action listener: _resource_record_post_action 13:21:40 INFO - ##### 13:21:40 INFO - ##### Running create-virtualenv step. 13:21:40 INFO - ##### 13:21:40 INFO - Running pre-action listener: _resource_record_pre_action 13:21:40 INFO - Running main action method: create_virtualenv 13:21:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:21:40 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:21:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:21:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:21:40 INFO - Using real prefix '/tools/python27' 13:21:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:21:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:21:43 INFO - Installing pip.................done. 13:21:43 INFO - Return code: 0 13:21:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:21: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:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:43 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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:21:43 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:21:43 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:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:43 INFO - 'HOME': '/Users/cltbld', 13:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:43 INFO - 'LOGNAME': 'cltbld', 13:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:43 INFO - 'MOZ_NO_REMOTE': '1', 13:21:43 INFO - 'NO_EM_RESTART': '1', 13:21:43 INFO - 'PAGER': '/bin/cat', 13:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:43 INFO - 'PWD': '/builds/slave/test', 13:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:43 INFO - 'SHELL': '/bin/bash', 13:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:21:43 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:43 INFO - 'USER': 'cltbld', 13:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:43 INFO - 'XPC_FLAGS': '0x0', 13:21:43 INFO - 'XPC_SERVICE_NAME': '0', 13:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:44 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:21:44 INFO - Cleaning up... 13:21:44 INFO - Return code: 0 13:21:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:21:44 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:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:44 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:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:44 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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:21:44 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:21:44 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:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:44 INFO - 'HOME': '/Users/cltbld', 13:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:44 INFO - 'LOGNAME': 'cltbld', 13:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:44 INFO - 'MOZ_NO_REMOTE': '1', 13:21:44 INFO - 'NO_EM_RESTART': '1', 13:21:44 INFO - 'PAGER': '/bin/cat', 13:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:44 INFO - 'PWD': '/builds/slave/test', 13:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:44 INFO - 'SHELL': '/bin/bash', 13:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:21:44 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:44 INFO - 'USER': 'cltbld', 13:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:44 INFO - 'XPC_FLAGS': '0x0', 13:21:44 INFO - 'XPC_SERVICE_NAME': '0', 13:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:44 INFO - Downloading/unpacking psutil>=0.7.1 13:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:47 INFO - Installing collected packages: psutil 13:21:47 INFO - Running setup.py install for psutil 13:21:47 INFO - building 'psutil._psutil_osx' extension 13:21:47 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:21:47 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:21:47 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:21:47 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:21:47 INFO - building 'psutil._psutil_posix' extension 13:21:47 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:21:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:21:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:21:47 INFO - ^ 13:21:47 INFO - 1 warning generated. 13:21:47 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:21:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:48 INFO - Successfully installed psutil 13:21:48 INFO - Cleaning up... 13:21:48 INFO - Return code: 0 13:21:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:21:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:21:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:48 INFO - 'HOME': '/Users/cltbld', 13:21:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:48 INFO - 'LOGNAME': 'cltbld', 13:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:48 INFO - 'MOZ_NO_REMOTE': '1', 13:21:48 INFO - 'NO_EM_RESTART': '1', 13:21:48 INFO - 'PAGER': '/bin/cat', 13:21:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:48 INFO - 'PWD': '/builds/slave/test', 13:21:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:48 INFO - 'SHELL': '/bin/bash', 13:21:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:21:48 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:21:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:48 INFO - 'USER': 'cltbld', 13:21:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:48 INFO - 'XPC_FLAGS': '0x0', 13:21:48 INFO - 'XPC_SERVICE_NAME': '0', 13:21:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:21:50 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:21:50 INFO - Installing collected packages: mozsystemmonitor 13:21:50 INFO - Running setup.py install for mozsystemmonitor 13:21:50 INFO - Successfully installed mozsystemmonitor 13:21:50 INFO - Cleaning up... 13:21:51 INFO - Return code: 0 13:21:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:51 INFO - 'HOME': '/Users/cltbld', 13:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:51 INFO - 'LOGNAME': 'cltbld', 13:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:51 INFO - 'MOZ_NO_REMOTE': '1', 13:21:51 INFO - 'NO_EM_RESTART': '1', 13:21:51 INFO - 'PAGER': '/bin/cat', 13:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:51 INFO - 'PWD': '/builds/slave/test', 13:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:51 INFO - 'SHELL': '/bin/bash', 13:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:21:51 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:51 INFO - 'USER': 'cltbld', 13:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:51 INFO - 'XPC_FLAGS': '0x0', 13:21:51 INFO - 'XPC_SERVICE_NAME': '0', 13:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:51 INFO - Downloading/unpacking blobuploader==1.2.4 13:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:53 INFO - Downloading blobuploader-1.2.4.tar.gz 13:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:21:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:21: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:21: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:21: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:21: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:21: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:21: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:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:21:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:54 INFO - Downloading docopt-0.6.1.tar.gz 13:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:21:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:21:54 INFO - Running setup.py install for blobuploader 13:21:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:21:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:21:55 INFO - Running setup.py install for requests 13:21:55 INFO - Running setup.py install for docopt 13:21:55 INFO - Successfully installed blobuploader requests docopt 13:21:55 INFO - Cleaning up... 13:21:55 INFO - Return code: 0 13:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:55 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:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:56 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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:21:56 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:21:56 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:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:56 INFO - 'HOME': '/Users/cltbld', 13:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:56 INFO - 'LOGNAME': 'cltbld', 13:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:56 INFO - 'MOZ_NO_REMOTE': '1', 13:21:56 INFO - 'NO_EM_RESTART': '1', 13:21:56 INFO - 'PAGER': '/bin/cat', 13:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:56 INFO - 'PWD': '/builds/slave/test', 13:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:56 INFO - 'SHELL': '/bin/bash', 13:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:21:56 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:56 INFO - 'USER': 'cltbld', 13:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:56 INFO - 'XPC_FLAGS': '0x0', 13:21:56 INFO - 'XPC_SERVICE_NAME': '0', 13:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:56 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-EuhGa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:56 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-wwPJuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:56 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-OOi5Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:21:56 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Z8VfbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:21:56 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Xq5rnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ip3YOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-JWu6Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-G2EQtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-V0xWun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-CbzBN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-crssfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-U5FXLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-8KFRMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:21:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ObYrB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Vd21Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:21:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_VjjH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:21:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-gqYvpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:21:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:21:58 INFO - Running setup.py install for manifestparser 13:21:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Running setup.py install for mozcrash 13:21:58 INFO - Running setup.py install for mozdebug 13:21:58 INFO - Running setup.py install for mozdevice 13:21:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Running setup.py install for mozfile 13:21:59 INFO - Running setup.py install for mozhttpd 13:21:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Running setup.py install for mozinfo 13:21:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Running setup.py install for mozInstall 13:21:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Running setup.py install for mozleak 13:21:59 INFO - Running setup.py install for mozlog 13:21:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Running setup.py install for moznetwork 13:21:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Running setup.py install for mozprocess 13:22:00 INFO - Running setup.py install for mozprofile 13:22:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:22:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:22:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:22:00 INFO - Running setup.py install for mozrunner 13:22:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:22:00 INFO - Running setup.py install for mozscreenshot 13:22:00 INFO - Running setup.py install for moztest 13:22:00 INFO - Running setup.py install for mozversion 13:22:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:22:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:22:00 INFO - Cleaning up... 13:22:00 INFO - Return code: 0 13:22:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:00 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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:22:00 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:22:00 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:22:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:22:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:00 INFO - 'HOME': '/Users/cltbld', 13:22:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:00 INFO - 'LOGNAME': 'cltbld', 13:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:00 INFO - 'MOZ_NO_REMOTE': '1', 13:22:00 INFO - 'NO_EM_RESTART': '1', 13:22:00 INFO - 'PAGER': '/bin/cat', 13:22:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:00 INFO - 'PWD': '/builds/slave/test', 13:22:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:00 INFO - 'SHELL': '/bin/bash', 13:22:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:22:00 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:22:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:00 INFO - 'USER': 'cltbld', 13:22:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:00 INFO - 'XPC_FLAGS': '0x0', 13:22:00 INFO - 'XPC_SERVICE_NAME': '0', 13:22:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:22:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-mKuXGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:22:01 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:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:22:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-GVJdnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:22:01 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:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:22:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-kGQ1Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:22:01 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:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:22:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-m6reHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:22:01 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:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:22:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-07r13k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:22:01 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:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:22:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jBwpqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:22:01 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:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:22:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-iulRxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:22:01 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:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:22:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-lxDLto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-fp1On2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ABlSb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ZlntP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Rsu1GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-n_YWbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-81jzB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-7WmXai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-FenWsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:22:02 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:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:22:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ctJunW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:22:02 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:22:02 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:22:02 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:22:02 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:22:02 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:22:02 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:22:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:22:03 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:22:03 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:22:03 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:22:03 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:22:03 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:22:03 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:22:05 INFO - Downloading blessings-1.6.tar.gz 13:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:22:05 INFO - Installing collected packages: blessings 13:22:05 INFO - Running setup.py install for blessings 13:22:06 INFO - Successfully installed blessings 13:22:06 INFO - Cleaning up... 13:22:06 INFO - Return code: 0 13:22:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:22:06 INFO - Reading from file tmpfile_stdout 13:22:06 INFO - Current package versions: 13:22:06 INFO - blessings == 1.6 13:22:06 INFO - blobuploader == 1.2.4 13:22:06 INFO - docopt == 0.6.1 13:22:06 INFO - manifestparser == 1.1 13:22:06 INFO - mozInstall == 1.12 13:22:06 INFO - mozcrash == 0.16 13:22:06 INFO - mozdebug == 0.1 13:22:06 INFO - mozdevice == 0.48 13:22:06 INFO - mozfile == 1.2 13:22:06 INFO - mozhttpd == 0.7 13:22:06 INFO - mozinfo == 0.9 13:22:06 INFO - mozleak == 0.1 13:22:06 INFO - mozlog == 3.1 13:22:06 INFO - moznetwork == 0.27 13:22:06 INFO - mozprocess == 0.22 13:22:06 INFO - mozprofile == 0.28 13:22:06 INFO - mozrunner == 6.11 13:22:06 INFO - mozscreenshot == 0.1 13:22:06 INFO - mozsystemmonitor == 0.0 13:22:06 INFO - moztest == 0.7 13:22:06 INFO - mozversion == 1.4 13:22:06 INFO - psutil == 3.1.1 13:22:06 INFO - requests == 1.2.3 13:22:06 INFO - wsgiref == 0.1.2 13:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22:06 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:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:06 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:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:06 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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:22:06 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:22:06 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:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:06 INFO - 'HOME': '/Users/cltbld', 13:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:06 INFO - 'LOGNAME': 'cltbld', 13:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:06 INFO - 'MOZ_NO_REMOTE': '1', 13:22:06 INFO - 'NO_EM_RESTART': '1', 13:22:06 INFO - 'PAGER': '/bin/cat', 13:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:06 INFO - 'PWD': '/builds/slave/test', 13:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:06 INFO - 'SHELL': '/bin/bash', 13:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:22:06 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:06 INFO - 'USER': 'cltbld', 13:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:06 INFO - 'XPC_FLAGS': '0x0', 13:22:06 INFO - 'XPC_SERVICE_NAME': '0', 13:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 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:22:06 INFO - Cleaning up... 13:22:06 INFO - Return code: 0 13:22:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:22:06 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:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:06 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:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:06 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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:22:06 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:22:06 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:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:06 INFO - 'HOME': '/Users/cltbld', 13:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:06 INFO - 'LOGNAME': 'cltbld', 13:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:06 INFO - 'MOZ_NO_REMOTE': '1', 13:22:06 INFO - 'NO_EM_RESTART': '1', 13:22:06 INFO - 'PAGER': '/bin/cat', 13:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:06 INFO - 'PWD': '/builds/slave/test', 13:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:06 INFO - 'SHELL': '/bin/bash', 13:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:22:06 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:06 INFO - 'USER': 'cltbld', 13:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:06 INFO - 'XPC_FLAGS': '0x0', 13:22:06 INFO - 'XPC_SERVICE_NAME': '0', 13:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:06 INFO - Downloading/unpacking jsonschema 13:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:22:09 INFO - Downloading/unpacking functools32 (from jsonschema) 13:22:09 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:22:09 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:22:09 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:22:09 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:22:09 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:22:09 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:22:09 INFO - Downloading functools32-3.2.3-2.tar.gz 13:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:22:09 INFO - warning: no files found matching '*.txt' 13:22:09 INFO - no previously-included directories found matching 'build' 13:22:09 INFO - no previously-included directories found matching 'dist' 13:22:09 INFO - no previously-included directories found matching '.git*' 13:22:09 INFO - Installing collected packages: jsonschema, functools32 13:22:09 INFO - Running setup.py install for functools32 13:22:09 INFO - warning: no files found matching '*.txt' 13:22:09 INFO - no previously-included directories found matching 'build' 13:22:09 INFO - no previously-included directories found matching 'dist' 13:22:09 INFO - no previously-included directories found matching '.git*' 13:22:09 INFO - Successfully installed jsonschema functools32 13:22:09 INFO - Cleaning up... 13:22:10 INFO - Return code: 0 13:22:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:22: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:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22: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:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:10 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 0x1059eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bb597450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, '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.cuMvAH4rqt/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.brjdGkRrDr/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:22:10 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:22:10 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:22:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:22:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:10 INFO - 'HOME': '/Users/cltbld', 13:22:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:10 INFO - 'LOGNAME': 'cltbld', 13:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:10 INFO - 'MOZ_NO_REMOTE': '1', 13:22:10 INFO - 'NO_EM_RESTART': '1', 13:22:10 INFO - 'PAGER': '/bin/cat', 13:22:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:10 INFO - 'PWD': '/builds/slave/test', 13:22:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:10 INFO - 'SHELL': '/bin/bash', 13:22:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:22:10 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:22:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:10 INFO - 'USER': 'cltbld', 13:22:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:10 INFO - 'XPC_FLAGS': '0x0', 13:22:10 INFO - 'XPC_SERVICE_NAME': '0', 13:22:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:10 INFO - Downloading/unpacking flake8 13:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:10 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:22:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:22:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:22:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 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:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:22:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:22:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:22:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:22:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:22:13 INFO - no previously-included directories found matching 'docs/_build' 13:22:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:22:13 INFO - Running setup.py install for pep8 13:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:22:14 INFO - no previously-included directories found matching 'docs/_build' 13:22:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:22:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:22:14 INFO - Cleaning up... 13:22:14 INFO - Return code: 0 13:22:14 INFO - Running post-action listener: _resource_record_post_action 13:22:14 INFO - Running post-action listener: _start_resource_monitoring 13:22:14 INFO - Starting resource monitoring. 13:22:14 INFO - ##### 13:22:14 INFO - ##### Running install step. 13:22:14 INFO - ##### 13:22:14 INFO - Running pre-action listener: _resource_record_pre_action 13:22:14 INFO - Running main action method: install 13:22:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:22:14 INFO - Reading from file tmpfile_stdout 13:22:14 INFO - Detecting whether we're running mozinstall >=1.0... 13:22:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:22:14 INFO - Reading from file tmpfile_stdout 13:22:14 INFO - Output received: 13:22:14 INFO - Usage: mozinstall [options] installer 13:22:14 INFO - Options: 13:22:14 INFO - -h, --help show this help message and exit 13:22:14 INFO - -d DEST, --destination=DEST 13:22:14 INFO - Directory to install application into. [default: 13:22:14 INFO - "/builds/slave/test"] 13:22:14 INFO - --app=APP Application being installed. [default: firefox] 13:22:14 INFO - mkdir: /builds/slave/test/build/application 13:22:14 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:22:14 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:22:48 INFO - Reading from file tmpfile_stdout 13:22:48 INFO - Output received: 13:22:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:22:48 INFO - Running post-action listener: _resource_record_post_action 13:22:48 INFO - ##### 13:22:48 INFO - ##### Running run-tests step. 13:22:48 INFO - ##### 13:22:48 INFO - Running pre-action listener: _resource_record_pre_action 13:22:48 INFO - Running main action method: run_tests 13:22:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:22:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:22:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:22:48 INFO - 2016-02-25 13:22:48.946 screenresolution[1961:17533] starting screenresolution argv=screenresolution get 13:22:48 INFO - 2016-02-25 13:22:48.948 screenresolution[1961:17533] Display 0: 1600x1200x32@60 13:22:48 INFO - 2016-02-25 13:22:48.954 screenresolution[1962:17535] starting screenresolution argv=screenresolution list 13:22:48 INFO - Available Modes on Display 0 13:22:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:22:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:22:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:22:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:22:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:22:49 INFO - Intel Iris: 13:22:49 INFO - Chipset Model: Intel Iris 13:22:49 INFO - Type: GPU 13:22:49 INFO - Bus: Built-In 13:22:49 INFO - VRAM (Dynamic, Max): 1536 MB 13:22:49 INFO - Vendor: Intel (0x8086) 13:22:49 INFO - Device ID: 0x0a2e 13:22:49 INFO - Revision ID: 0x0009 13:22:49 INFO - Displays: 13:22:49 INFO - Display: 13:22:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:22:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:22:49 INFO - Display Serial Number: 1600x1200 60 13:22:49 INFO - Main Display: Yes 13:22:49 INFO - Mirror: Off 13:22:49 INFO - Online: Yes 13:22:49 INFO - Rotation: Supported 13:22:49 INFO - Return code: 0 13:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:22:49 INFO - Python 2.7.3 13:22:49 INFO - Return code: 0 13:22:49 INFO - grabbing minidump binary from tooltool 13:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:49 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 0x10588fd30>, '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 0x1056b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105886b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:22:49 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:22:49 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:22:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:22:49 INFO - Return code: 0 13:22:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:22:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:22:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:22:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:22:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:22:50 INFO - Return code: 0 13:22:50 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:22:50 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:22:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cuMvAH4rqt/Render', 13:22:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:50 INFO - 'HOME': '/Users/cltbld', 13:22:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:50 INFO - 'LOGNAME': 'cltbld', 13:22:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:22:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:50 INFO - 'MOZ_NO_REMOTE': '1', 13:22:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:22:50 INFO - 'NO_EM_RESTART': '1', 13:22:50 INFO - 'PAGER': '/bin/cat', 13:22:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:50 INFO - 'PWD': '/builds/slave/test', 13:22:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:22:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:50 INFO - 'SHELL': '/bin/bash', 13:22:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.brjdGkRrDr/Listeners', 13:22:50 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 13:22:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:50 INFO - 'USER': 'cltbld', 13:22:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:50 INFO - 'XPC_FLAGS': '0x0', 13:22:50 INFO - 'XPC_SERVICE_NAME': '0', 13:22:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:22:50 INFO - mozversion application_buildid: 20160225113726 13:22:50 INFO - mozversion application_changeset: ad4d966f23677027aa0bd08f195f1478dd9d6d8c 13:22:50 INFO - mozversion application_display_name: Nightly 13:22:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:22:50 INFO - mozversion application_name: Firefox 13:22:50 INFO - mozversion application_remotingname: firefox 13:22:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:22:50 INFO - mozversion application_vendor: Mozilla 13:22:50 INFO - mozversion application_version: 47.0a1 13:22:50 INFO - mozversion platform_buildid: 20160225113726 13:22:50 INFO - mozversion platform_changeset: ad4d966f23677027aa0bd08f195f1478dd9d6d8c 13:22:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:22:50 INFO - mozversion platform_version: 47.0a1 13:22:50 INFO - using testdate: 1456435370 13:22:50 INFO - actual date: 1456435370 13:22:50 INFO - starting webserver on 'localhost:56108' 13:22:50 INFO - SUITE-START | Running 2 tests 13:22:50 INFO - TEST-START | dromaeo_css 13:22:50 INFO - operating with platform_type : mac_ 13:22:50 INFO - Initialising browser for dromaeo_css test... 13:22:50 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmp4SK29H/profile http://localhost:56108/getInfo.html) 13:22:53 INFO - PROCESS | 1980 | __metrics Screen width/height:1600/1200 13:22:53 INFO - PROCESS | 1980 | colorDepth:24 13:22:53 INFO - PROCESS | 1980 | Browser inner width/height: 1024/689 13:22:53 INFO - PROCESS | 1980 | __metrics 13:22:53 ERROR - PROCESS | 1980 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:22:54 INFO - TEST-INFO | 1980: exit 0 13:22:54 INFO - Browser initialized. 13:22:54 INFO - Running cycle 1/1 for dromaeo_css test... 13:22:54 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmp4SK29H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:23:06 INFO - PROCESS | 1985 | RSS: Main: 256053248 13:23:06 INFO - PROCESS | 1985 | 13:23:56 INFO - PROCESS | 1985 | 1456435436131 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:26:06 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:56108/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56108/tests/dromaeo/cssquery-ext.html) 13:26:07 INFO - PROCESS | 1985 | RSS: Main: 272101376 13:26:07 INFO - PROCESS | 1985 | 13:29:09 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:56108/tests/dromaeo/cssquery-ext.html (next: http://localhost:56108/tests/dromaeo/cssquery-jquery.html) 13:29:10 INFO - PROCESS | 1985 | RSS: Main: 283852800 13:29:10 INFO - PROCESS | 1985 | 13:32:12 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:56108/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56108/tests/dromaeo/cssquery-mootools.html) 13:32:12 INFO - PROCESS | 1985 | RSS: Main: 285802496 13:32:12 INFO - PROCESS | 1985 | 13:35:14 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:56108/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56108/tests/dromaeo/cssquery-prototype.html) 13:35:15 INFO - PROCESS | 1985 | RSS: Main: 288153600 13:35:15 INFO - PROCESS | 1985 | 13:38:17 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:56108/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56108/tests/dromaeo/cssquery-yui.html) 13:38:18 INFO - PROCESS | 1985 | RSS: Main: 288731136 13:38:18 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:56108/tests/dromaeo/cssquery-yui.html (next: http://localhost:56108/tests/dromaeo/cssquery-dojo.html) 13:41:20 INFO - PROCESS | 1985 | RSS: Main: 290856960 13:41:20 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | __start_tp_report 13:41:20 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 13:41:20 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 13:41:20 INFO - PROCESS | 1985 | |i|pagename|runs| 13:41:20 INFO - PROCESS | 1985 | |0;dojo.html;2925.4587901238274;3530.505729197913;3547.8048707321104;3553.4847447120183;3587.426011838106;4457.331400289958;4683.976580117099;5016.896282817779;5742.196092547047;5809.302883653957;5625.915611265835;5698.430156984299;5746;5842.2989241291;5930.762769489215;5177.068127737015;5240.633155679104;5307.708076055816;5313.628046036779;5322.627416080876;5222.242774797652;5239.52844244018;5341.679499230039;5372.838814835562;5399.5680345572455;4491.820327186909;5137.3064636274;5205.427402985669;5231.738413079331;5247.606429517801;4223.556526564697;5169.689818610896;5204.843854684365;5206.5314121729225;5214.608904332153;5156.381234251914;5180.6373553851245;5207.791688332462;5211.5830733541225;5214;5370.355557333106;5550;5611.102223644198;5720.2849643794525;5724.513416359614;6182.84542886427;6185.41238582334;6200.100985357098;6204.47261982732;6207.782727604557;6204.255489341263;6241.095041219043;6263.843403914893;6268.09112678659;6270.937290627081;4889.266610008492;5735.168400581934;5775.018246897996;5796.797112101056;5802.65184088956;6240.344763799736;6281.466075383552;6298.968505157445;6309.337519560472;6317.210348706411;6068.4538391544975;6204.007358822567;6219;6220.911340515482;6232.3144454110015;6224.906626400608;6227.595206311576;6298.496120310364;6302.842428939313;6306.274778400542;6060.090986351995;6113.816585502442;6184.567080304336;6186.783462578878;6186.938130618636;6088.417011577022;6114.449699527064;6219.689015549205;6245.313015568284;6265.342139075331;4895.510448955076;4903.945651684905;4934.8766280843265;4937.925931111036;4979.45226025137;4407.823687052546;4441.800118994653;4442.577955094261;4451.799669014902;4482.39487669167;5630.634008789498;5653.575981801381;5774.422557744192;5805.419458054161;5848.5321174305955;6206.162168107247;6215.502759779297;6269.185005949197;6292.402221788922;6295.370462953668;5786.94213057864;5807.82576522705;5825.155352473867;5857.648541087548;5860.560457965669;5292.655977361459;5359.651622644516;5420;5424.864378390572;5607.990561698934;6337.302896681362;6340.556161068773;6355.428011478989;6359.014352775327;6361.268454127835;6253.37466253371;6261.843453913689;6264.4048815364295;6272.18461599989;6280.120783090462;5256.737163141904;6189.473894718819;6245.219347581552;6304.7162877671535;6314.905276420949;6208.9689551551955;6218.409251121137;6226.533010024175;6256.468200203034;6257.4681152102585;6249.500039996698;6273.435390814849;6279.591826531261;6285.811425657238;6293.811185664437;5920.79277225295;6018.187544681412;6117.979653188298;6127.3259941407305;6157.692115394123;6100.667974472981;6114.246153692847;6122.418370254819;6150.630962142286;6197;5577.693226872399;5626.127950167731;5676.148577713376;5678.261825962599;5778.393268706894;5847.561432892465;6065.059915713072;6119.715820550834;6122.173506576555;6162.352952940056;5959.22530071088;6034.818955431344;6057.061155520902;6067.180930574493;6076.57463977535 13:41:20 INFO - PROCESS | 1985 | |1;ext.html;435.5448556258709;483.7557033697983;500.914844476439;534.8287250920484;591.9881602367956;36691.4496282556;37215.62784372155;37344.62655373445;37350.252994940085;37367.06582335443;34325.82837085811;37247.068823279435;38318.61681383185;38439.80780096095;38753.8373848785;9300.348975571713;9455.952720236424;9507.286953478482;9520.666776662818;9579.377340472882;9387.389819661734;9569.95215023924;9594.088561586637;9625.22998160149;9653.5173241338;9595.184409325217;9621.08599683029;9642.084002019832;9658.034196580356;9658.420494770302;9550.235981121494;9625.374350667184;9639.469829159394;9671.177949874269;9723.02769723029;9448.95275523618;9522.571484283224;9579.425234485952;9584.137427631476;9594.568244428947;36917.63082369169;37277;37496.06259843498;37594.62405375966;37603.43594846079;3182.347618738153;3182.9522557161663;3333.799972001688;3371.561696979377;3584.8207589620674;27519.58720619192;27926.301842453897;28091.57862632062;28507.57238641422;28847.56728649051;2774.8612569371653;2781.707920668341;2849.2591926099158;2877.438899414615;2980.9850950745326;408204;491870.0812991896;492070;493540;493723.5313823444;35147;44706.55293447024;44816.77591612021;62618;63644.727105457634;43247.56752432435;43585.56414435879;43658.781706091904;43739.78130109393;43844.12311753747;12844;15085.24573771307;15163.848361516464;15276.38894444232;15366.462173823862;12085.45615447307;12188.756224875453;12295.385230738428;12385.009199264037;12402.19385739924;14283.571492855232;14493;14500.492482763264;14538.927305363406;14631.780523292158;6178.907316390258;6256.781012664626;6276.340984196685;6291.276503202099;6307.747690092437;898.714837781965;976.8144052629978;981.6760469045198;985.3102828020415;1077.4612693653173;26821.927122915255;28730.42539149247;28733.56899646507;29110.708892911225;29465;1082.8592283003318;1085.9402732849612;1100.070440477795;1154.6074334726234;1160.23424539805;14580.125192488485;14689.632759180893;14740.926295368668;14842.554723358317;15142.54572362831;515777;516640.4167979136;518472;519705;523891;55310;55415.72292138594;55959;56018.719906400205;56161.87676246452;1351.3175846197607;1369.3700897587023;1384.6746014686541;1392.2273138408282;1399.5381524097227;28162.732677029173;28163.71836281693;28275.15174544767;28340;28526.57210141808;47839.521604783506;47876;47964.7601761989;48245.5175448241;48397.5160248393;458711;461711;462978;463067;463618;26746.86626566855;32243.35513289674;41082.1783564333;42501.93745156396;43790.68627941167;40566.39150412805;41352.79323603363;41752.74741757752;42261;42368.36447453229;28221.373055702214;34111.65888341085;35303.47044794279;35602.575896963834;35858.8207058963;33175.004749857544;33194.336113278085;35206.82396588001;35310.47034294539;35987.64012359843;35829.82085089558;35864.82067589645;36421.45367819432;37015;37047.073823154635;29426.558601620563;31646.525302120026;31653.050408487783;31701.04896853098;31823.68176318207;23789.881050594635;23867.522649546565;24013.91937362788;24355;24462 13:41:20 INFO - PROCESS | 1985 | |2;jquery.html;343.54308769336785;347.64988676546545;349.3990336621012;354.374528956392;354.57982290985166;18453.815461845377;18766.812331876677;19268.036598170107;19272.421827345202;19634.70547941782;19346.51633709158;19685.704714429296;20066.996650167504;20348.491287717814;20494.590108197826;5574.749136288867;5863.973804584202;5901.734421951001;5903.704814759266;5909.231799866033;4163.2298024865495;5712.628679135863;6088.269407671086;6366.872662546746;6379.489640828746;6278.937210627881;6306.211723534559;6318.178636777213;6320.873582528347;6327.715252813611;6071.1803906472505;6404.583702059374;6420.807375778734;6469.83825404364;6478;5387.730613469311;5450.700211488366;5492.450754924515;5525.198846167324;5538.307711536058;23707.644385334235;24292.392690182885;24363.634545481833;24411.87794061036;24437.38906527333;1764.9382271620432;2054.7226124473154;2181.182056728727;2617.882195301197;2845.6869744328105;9300.395474294217;9680.370775899544;9824.164945979528;9842.852357214648;14529.491467798576;1657.627033917371;1674.7990241171137;1700.5153531243536;1755.965335760351;1804.0979510244877;79520.60239698822;99646.5017674907;101535;103643.4817825906;104755;11044.226904116635;11063.778724425467;11067.280626759235;11131.777364452666;11155.27490713101;13199;13240.801387979189;13242.668933276746;13277.605851385466;13382.063255572211;6207.131001659771;8291.875621865676;8377.37169712274;8416.957915210507;8542.530160841214;6681.799546013627;7918.920810791818;8086.555239461768;8595.226429621363;8725.996510401385;3595.4606808978338;4350.129974005212;4368.235558777201;4400.9559904401185;4442.444694413199;1754.9912250438665;1780.261191605495;1814.845738112249;1827.2782251010776;1845.8061903499938;834.3950635789005;900.2392977933636;940.7234492528098;969.888462826784;989.302541708094;18312.450626481226;18942.810571894104;18943.336983205798;19170.329038483866;19421.611567768567;936.279065119854;938.474454305591;956.6269155029544;977.3305285879195;1012.8126296635146;9968.102870741668;10393.428361440043;10495.685129446128;10517.52671129801;10540.578376864993;456921;523401;532436;535982;645360;104587.47706261573;106131;127546;132432;135310;990.3414229537422;1004.2167109654481;1034.4775888176573;1036.0571879589538;1041.375174895072;17607;17607.20767565488;17807.643847122727;18248;18419.355322563646;49856.00287994292;50042;52790;52969.94060118699;53599;68673;69206.30793691998;69646.65176674085;69825.65087174531;73916.63041684758;7744.954431151722;7936.127026027248;7957.1644977276555;7980.84038319242;8115.59422028908;12682.87317126817;12773.425195866394;12934;13224;13392.129511581716;9520.619175232912;11372;11661.416929153678;11709.414529273332;11753.471093800628;9382.530873456164;11346.149038821955;11371.43142842871;11413.714657133638;11749.88250117488;7811.8286553622;11565.479553419947;11595.072394208275;11952.163348565864;12042.578509752117;7943.285104340637;7956.92043079585;7995;8050.355971522147;8314.127016663164;8619.91380086191;8836.558172091241;10252.282340236112;10853.294535855144;11530.711732206762 13:41:20 INFO - PROCESS | 1985 | |3;mootools.html;1394.6373942774878;1516.226724370571;1715.2795825753183;1867;1904.1526520698294;7866.449348545604;8519.659213631447;8587.699430519933;8787.95606021969;8804.559772011398;8606.440581362207;8662.003869555003;8706.651733930636;8725.127487251271;8729.91270087299;2439.402346425128;2440.6949131358624;2466.3957330454064;2467.8889449974795;2468.0004598137784;2399.7524381844128;2442.829001969863;2450.3751543356507;2454.631805229212;2458.397692565315;2452.1172377943926;2457.7542245775458;2467;2467.605183170693;2473.6907886514186;2424.59994100974;2444.718857331412;2449.1795248591743;2457.508498300347;2467.938301542458;2027.2701827342146;2388.665586817847;2411.3248290478696;2414.2033129067368;2427.077710470028;8722.563871806384;8729.170728780819;8747.606357713854;8762.605682744228;8788.692395766182;5212.29633999409;5298.417174110845;5343.973280133613;5344.011357898801;5430.91853622196;3012.472817256993;3593.892183234481;3671.8531258749617;3692.3538380783257;3732.757370770891;859.8882145321131;1048.1195795531714;1076.2358725305044;1630.3723066619318;1666.1086318819373;11483.712907177303;11537;11595.536178552848;11628.709282268012;11652.883471165265;4587.7017993830295;4650.000249946278;4717.834875779331;4733.195356789354;4783.641226907996;9145.0397708241;9173.495457749754;9179.77050573741;9201.171894529525;9207.17135457812;4583;4598.908021839611;5233.371995360581;5376.220448035091;5388.625900395374;4445.288753799441;4817.0606731686985;4885.022995400934;4892.681975671641;5021.6735912165595;3708.5364329458816;3746.868859589901;3794.5636251830842;3811.294910441577;3816.0078379620945;1186;1192.117832803719;1197.3713800254936;1200.3338147328316;1202.464903118104;1336.9732605347838;1340.9396577154052;1360.4286199796109;1365.5661555366826;1377.9104358216684;8047.597620118971;8211.712590059438;8246.422750407533;8269.131741167212;8294.543800091053;504.4400715206118;509.8750806052541;510.9540141387293;516.9534741873249;519.631061946015;5975.790847320323;6089.695515224221;6094.055421409688;6138.508919286535;6176.166217560572;10113.949430252802;10384.169266458664;10405.271630985759;10406.687799366031;10494.160467162608;10133.08802207805;10273;10363.533640986174;10388.792224155626;10437.843432348522;8147.307478864363;8245.13426090264;8254.958725206456;8303.211194936472;8316.41785075039;7926.920730792618;7966.083900351302;7983.640736166771;7996.280334769898;8014.879776803236;9185.908140918506;9354.859677104712;9412.623495060121;9501.809963800824;9599.184069353903;9682.806343872942;9815.901840981498;9847.212223022285;9875.506224688881;9914.504274786375;6762.661866906733;7130.964345178241;7354.264573542603;7386.926130738624;7489.812754680958;8044.798880028046;8116.553589552395;8149.266566009088;8178.100408955129;8187.631556579849;7129.928700712927;7221.169565500035;7248.746293879689;7347.302006309392;7394.815129621587;7083.327083927019;7153.320434558708;7156.964215178891;7186.1376634804155;7232.276772322725;7574.204708505527;7649.082110146818;7653.540787552764;7656.923430765621;7683.577403242875;6849.1438570178725;6939.965300173467;6941.305869413019;6946.235914049349;6979.127609048869;6888.173419189729;7047.823804404931;7052.012718219556;7069.9646501767165;7080.575165490087 13:41:20 INFO - PROCESS | 1985 | |4;prototype.html;320.55602989859045;324.39014652453386;327.0613339715018;331.30591410993975;334.9933001339972;6741.865162696743;6767.695453704583;6773.356531129547;6774.051632771416;6803;6627.304133066031;6655.201375834895;6679.5658282211625;6696.952886436672;6698.531102822804;3893.8831835044853;4305.5909688579695;4813.326134341195;4969.25461180824;5001.199808030716;4918.581920536759;4946.897568533377;4975.7263350515705;4987.775550100254;5007.549320561149;4915.213565829468;4924.753762311888;4930.087933732253;4933.481984391641;4946.159152944008;3965.861194858166;4923.458419573844;4939.975300123512;4944.975275123619;4959.181735013701;4205.726627769216;4207.91584168318;4216.894577635553;4224.683148763825;4246.299360605496;5945.316288626776;6336.841578960563;6389.584676995981;6489.902651460232;6510.967445162792;5822.621529600562;5870.73581688825;5875.529957603424;5900.232969713909;5909.9704501477645;7141.89287160693;7164;7174.1032370953635;7175.641217939135;7193.640317984132;4740.644451666139;4740.952590474086;4742.146413645542;4747.477777444478;4748.0978614063215;7552.735654252075;7574.394048476164;7589.089309282866;7593.354564861993;7595.620218989028;3419.26485805553;3815.599362066943;4285.928517870532;4627.236505976476;4825.662203645781;4710.62315014798;4718.2214934536105;4719.480857105716;4722;4742;4638.536146385334;5647.237622920935;5664.320281566238;5669.121286200563;5679.034564124109;5796;7204.207537170907;7222.313880181375;7246.130464344313;7273.745418910313;1365.7503384403358;1641.720907445737;1659.4192032788428;1661.5264649574813;1664.6837100950781;1015.6140666546665;1057.3021805608262;1059.6397224943403;1069.668402795136;1073.849661047454;6717.56335838169;6729.798106056826;6737.3599508046655;6748.358905903931;6760.391564759196;7505.737299194502;7518.28576285252;7533.849323013509;7538.472306938571;7559.697612095564;5786.958347497491;6566.146400967844;6606.405423511907;6775.390214880685;6797.388235058868;3829.463875057494;3967.4247234150885;4003.179348233605;4017.417474466186;4019.537753158366;7889.644965976545;7901.2888840003525;7929.20707929214;7936.127026027132;7941.880871786928;7589.43079269046;7824.84350313002;7828.178041305695;7832.451728378959;7881.960590197013;7674.079110506775;7941.324987376138;7984.20157984197;7988.640511177011;8017;7587.734429294948;7616.80957976055;7652.196519365387;7652.73215437457;7667.808304792202;7500.399968002655;7510.849783004419;7522;7522.097348318237;7543.73596924105;7591.62041897914;7913;7963.243491868263;8008.639611217625;8016.1182269949095;4591.747453889934;4596.724196548218;4629.606483448944;4633.6368452090355;4636.095961287517;7537.698492060256;7583.2416758323725;7586.658600362886;7592.468527203264;7600.961995189989;5503.559715222693;7300.890486642598;7315;7325.963370183328;7330.523515971445;5967.283925928917;7014.473914456335;7239.095113110861;7271.927280727336;7325.926740732524;6995.895061573979;7060.399866011241;7074.540154889915;7081.398081163159;7124.287571242834;7232.421406287379;7262.818429539304;7266;7280.672369743268;7294.379977701955;7106.218315985341;7143.678534465857;7146.392556632536;7149.892751608834;7193.0289410930945 13:41:20 INFO - PROCESS | 1985 | |5;yui.html;624.7532224771215;652.1163823019808;656.704482982658;683.9658017099147;727.9126504819423;14618;14812.555623331318;14848.628784280385;14867.55397338079;14878.18170000651;11029.393383363911;13400.59798206053;13404.195748255112;13486.595402137951;15502.379904803822;841.4236248170023;855.7903313688124;855.8844555984956;857.5926434943415;857.618359829876;697.9092717946685;826.4875777018257;853.6670698427619;866.3459088388258;869.4174902815129;909.4906852162777;915.3318077803208;915.5605309451435;917.3899356927635;920.6593560382668;904.479924043671;910.9590068446903;912.803747194353;913.684778751333;914.634146341462;662.1292999705372;669.6651674162919;674.103442421583;677.0757915445431;677.837319043431;15174.468893588672;15250.466233681878;15291.464798732102;15305.61735956599;15357.462488812838;12402.379881005914;12445.813312800316;12469.812952805714;12481.251124932533;12525.185862918881;9951.104400603981;10014.89985100147;10171.288009839314;10176.185905127571;10188.694339169837;3408.3183363327435;3455.9308813823836;3485.2855164691177;3548.538689970313;3548.6451354864566;54761.1785823213;83646;84849.15150848475;85129.57435212785;86600.56699716524;9223.538823058954;9298.628054877729;9309.813803723888;9318.440893546409;9430.95284523573;16713.749293760604;20062.498437538885;20756.377308680763;20803.68794468084;20855.687164692543;7182.141701714676;7205.099362579677;7383.593902335423;7391.408687305003;7487.3261406473675;4004.2828675384485;4026.375911733686;4158.376243563429;4164.37534369847;4174.770387628649;3531.434970404723;3573.7855728656364;3573.8391772370305;3578.5347904772734;3591.0304217861553;641.7914177892204;654.5581732330658;654.9639769812611;658.111549408295;658.7760161545098;556.4352182534731;577.7255803493307;590.5157770628044;594.9048152295612;595.4235469242144;7398.779201431704;7977.800554986172;8040.919590804017;8235.50586964784;8343.624536895733;499.2835281371244;523.4033202149552;563.4534501533506;602.1269159718425;618.904069869171;3761.1161377076364;3785.7096456643885;3797.962020379761;3835.079580900564;3875.6511913927884;87274.1272587266;87874;88462;88647.55676221578;89731.65402518968;71203.6439817808;73344.2665573348;73558;74332;74979;48017.519824802;57964.42035579675;68353.2911677202;69209.65395172992;70824.2917570828;7547.076313181367;7654.961725191339;7655.46411751172;7720.189380115232;7907.56508392044;49765.502344976085;50064;50880.491195087576;50957.74521127371;51222;66612.33387666062;66939;67584.6620766893;68490.65754671195;68915;8815.515146666994;9012.63949442015;9611.663591774533;9636.518174091407;9741.9025809741;10139.290249682452;10774.892251077703;11599.420028998347;12126.818097728365;13267.800982985456;11277.323360598062;11301.773964520828;11407.144464165054;11907.464164112462;12359.938200308941;11374.94312528432;11730.70673233176;11811.173217874666;11815.704607384883;11839.467223974769;10886.727831803952;11341.376224307742;11603.941980290045;11614.941925290319;11763.411829408666;9522.428654280766;9711.757206069904;9838.409695418297;9899.703008909744;9931.553080111267;8765.693200738198;8927.419717718327;9253.444793312154;9547.809043818947;9713.368631039242 13:41:20 INFO - PROCESS | 1985 | __end_tp_report 13:41:20 INFO - PROCESS | 1985 | __start_cc_report 13:41:20 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,357 13:41:20 INFO - PROCESS | 1985 | __end_cc_report 13:41:20 INFO - PROCESS | 1985 | __startTimestamp1456436480900__endTimestamp 13:41:20 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | ------- Summary: start ------- 13:41:20 INFO - PROCESS | 1985 | Number of tests: 6 13:41:20 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | [#0] dojo.html Cycles:165 Average:5718.15 Median:5930.76 stddev:664.67 (11.2%) stddev-sans-first:629.57 13:41:20 INFO - PROCESS | 1985 | Values: 2925.5 3530.5 3547.8 3553.5 3587.4 4457.3 4684.0 5016.9 5742.2 5809.3 5625.9 5698.4 5746.0 5842.3 5930.8 5177.1 5240.6 5307.7 5313.6 5322.6 5222.2 5239.5 5341.7 5372.8 5399.6 4491.8 5137.3 5205.4 5231.7 5247.6 4223.6 5169.7 5204.8 5206.5 5214.6 5156.4 5180.6 5207.8 5211.6 5214.0 5370.4 5550.0 5611.1 5720.3 5724.5 6182.8 6185.4 6200.1 6204.5 6207.8 6204.3 6241.1 6263.8 6268.1 6270.9 4889.3 5735.2 5775.0 5796.8 5802.7 6240.3 6281.5 6299.0 6309.3 6317.2 6068.5 6204.0 6219.0 6220.9 6232.3 6224.9 6227.6 6298.5 6302.8 6306.3 6060.1 6113.8 6184.6 6186.8 6186.9 6088.4 6114.4 6219.7 6245.3 6265.3 4895.5 4903.9 4934.9 4937.9 4979.5 4407.8 4441.8 4442.6 4451.8 4482.4 5630.6 5653.6 5774.4 5805.4 5848.5 6206.2 6215.5 6269.2 6292.4 6295.4 5786.9 5807.8 5825.2 5857.6 5860.6 5292.7 5359.7 5420.0 5424.9 5608.0 6337.3 6340.6 6355.4 6359.0 6361.3 6253.4 6261.8 6264.4 6272.2 6280.1 5256.7 6189.5 6245.2 6304.7 6314.9 6209.0 6218.4 6226.5 6256.5 6257.5 6249.5 6273.4 6279.6 6285.8 6293.8 5920.8 6018.2 6118.0 6127.3 6157.7 6100.7 6114.2 6122.4 6150.6 6197.0 5577.7 5626.1 5676.1 5678.3 5778.4 5847.6 6065.1 6119.7 6122.2 6162.4 5959.2 6034.8 6057.1 6067.2 6076.6 13:41:20 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | [#1] ext.html Cycles:180 Average:61421.77 Median:37347.44 stddev:129546.24 (346.9%) stddev-sans-first:129828.73 13:41:20 INFO - PROCESS | 1985 | Values: 435.5 483.8 500.9 534.8 592.0 36691.4 37215.6 37344.6 37350.3 37367.1 34325.8 37247.1 38318.6 38439.8 38753.8 9300.3 9456.0 9507.3 9520.7 9579.4 9387.4 9570.0 9594.1 9625.2 9653.5 9595.2 9621.1 9642.1 9658.0 9658.4 9550.2 9625.4 9639.5 9671.2 9723.0 9449.0 9522.6 9579.4 9584.1 9594.6 36917.6 37277.0 37496.1 37594.6 37603.4 3182.3 3183.0 3333.8 3371.6 3584.8 27519.6 27926.3 28091.6 28507.6 28847.6 2774.9 2781.7 2849.3 2877.4 2981.0 408204.0 491870.1 492070.0 493540.0 493723.5 35147.0 44706.6 44816.8 62618.0 63644.7 43247.6 43585.6 43658.8 43739.8 43844.1 12844.0 15085.2 15163.8 15276.4 15366.5 12085.5 12188.8 12295.4 12385.0 12402.2 14283.6 14493.0 14500.5 14538.9 14631.8 6178.9 6256.8 6276.3 6291.3 6307.7 898.7 976.8 981.7 985.3 1077.5 26821.9 28730.4 28733.6 29110.7 29465.0 1082.9 1085.9 1100.1 1154.6 1160.2 14580.1 14689.6 14740.9 14842.6 15142.5 515777.0 516640.4 518472.0 519705.0 523891.0 55310.0 55415.7 55959.0 56018.7 56161.9 1351.3 1369.4 1384.7 1392.2 1399.5 28162.7 28163.7 28275.2 28340.0 28526.6 47839.5 47876.0 47964.8 48245.5 48397.5 458711.0 461711.0 462978.0 463067.0 463618.0 26746.9 32243.4 41082.2 42501.9 43790.7 40566.4 41352.8 41752.7 42261.0 42368.4 28221.4 34111.7 35303.5 35602.6 35858.8 33175.0 33194.3 35206.8 35310.5 35987.6 35829.8 35864.8 36421.5 37015.0 37047.1 29426.6 31646.5 31653.1 31701.0 31823.7 23789.9 23867.5 24013.9 24355.0 24462.0 13:41:20 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | [#2] jquery.html Cycles:180 Average:32133.61 Median:351.89 stddev:90411.92 (25693.5%) stddev-sans-first:90634.04 13:41:20 INFO - PROCESS | 1985 | Values: 343.5 347.6 349.4 354.4 354.6 18453.8 18766.8 19268.0 19272.4 19634.7 19346.5 19685.7 20067.0 20348.5 20494.6 5574.7 5864.0 5901.7 5903.7 5909.2 4163.2 5712.6 6088.3 6366.9 6379.5 6278.9 6306.2 6318.2 6320.9 6327.7 6071.2 6404.6 6420.8 6469.8 6478.0 5387.7 5450.7 5492.5 5525.2 5538.3 23707.6 24292.4 24363.6 24411.9 24437.4 1764.9 2054.7 2181.2 2617.9 2845.7 9300.4 9680.4 9824.2 9842.9 14529.5 1657.6 1674.8 1700.5 1756.0 1804.1 79520.6 99646.5 101535.0 103643.5 104755.0 11044.2 11063.8 11067.3 11131.8 11155.3 13199.0 13240.8 13242.7 13277.6 13382.1 6207.1 8291.9 8377.4 8417.0 8542.5 6681.8 7918.9 8086.6 8595.2 8726.0 3595.5 4350.1 4368.2 4401.0 4442.4 1755.0 1780.3 1814.8 1827.3 1845.8 834.4 900.2 940.7 969.9 989.3 18312.5 18942.8 18943.3 19170.3 19421.6 936.3 938.5 956.6 977.3 1012.8 9968.1 10393.4 10495.7 10517.5 10540.6 456921.0 523401.0 532436.0 535982.0 645360.0 104587.5 106131.0 127546.0 132432.0 135310.0 990.3 1004.2 1034.5 1036.1 1041.4 17607.0 17607.2 17807.6 18248.0 18419.4 49856.0 50042.0 52790.0 52969.9 53599.0 68673.0 69206.3 69646.7 69825.7 73916.6 7745.0 7936.1 7957.2 7980.8 8115.6 12682.9 12773.4 12934.0 13224.0 13392.1 9520.6 11372.0 11661.4 11709.4 11753.5 9382.5 11346.1 11371.4 11413.7 11749.9 7811.8 11565.5 11595.1 11952.2 12042.6 7943.3 7956.9 7995.0 8050.4 8314.1 8619.9 8836.6 10252.3 10853.3 11530.7 13:41:20 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | [#3] mootools.html Cycles:180 Average:5941.39 Median:5360.12 stddev:3125.13 (58.3%) stddev-sans-first:3115.21 13:41:20 INFO - PROCESS | 1985 | Values: 1394.6 1516.2 1715.3 1867.0 1904.2 7866.4 8519.7 8587.7 8788.0 8804.6 8606.4 8662.0 8706.7 8725.1 8729.9 2439.4 2440.7 2466.4 2467.9 2468.0 2399.8 2442.8 2450.4 2454.6 2458.4 2452.1 2457.8 2467.0 2467.6 2473.7 2424.6 2444.7 2449.2 2457.5 2467.9 2027.3 2388.7 2411.3 2414.2 2427.1 8722.6 8729.2 8747.6 8762.6 8788.7 5212.3 5298.4 5344.0 5344.0 5430.9 3012.5 3593.9 3671.9 3692.4 3732.8 859.9 1048.1 1076.2 1630.4 1666.1 11483.7 11537.0 11595.5 11628.7 11652.9 4587.7 4650.0 4717.8 4733.2 4783.6 9145.0 9173.5 9179.8 9201.2 9207.2 4583.0 4598.9 5233.4 5376.2 5388.6 4445.3 4817.1 4885.0 4892.7 5021.7 3708.5 3746.9 3794.6 3811.3 3816.0 1186.0 1192.1 1197.4 1200.3 1202.5 1337.0 1340.9 1360.4 1365.6 1377.9 8047.6 8211.7 8246.4 8269.1 8294.5 504.4 509.9 511.0 517.0 519.6 5975.8 6089.7 6094.1 6138.5 6176.2 10113.9 10384.2 10405.3 10406.7 10494.2 10133.1 10273.0 10363.5 10388.8 10437.8 8147.3 8245.1 8255.0 8303.2 8316.4 7926.9 7966.1 7983.6 7996.3 8014.9 9185.9 9354.9 9412.6 9501.8 9599.2 9682.8 9815.9 9847.2 9875.5 9914.5 6762.7 7131.0 7354.3 7386.9 7489.8 8044.8 8116.6 8149.3 8178.1 8187.6 7129.9 7221.2 7248.7 7347.3 7394.8 7083.3 7153.3 7157.0 7186.1 7232.3 7574.2 7649.1 7653.5 7656.9 7683.6 6849.1 6940.0 6941.3 6946.2 6979.1 6888.2 7047.8 7052.0 7070.0 7080.6 13:41:20 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | [#4] prototype.html Cycles:180 Average:5887.36 Median:6708.05 stddev:1949.65 (29.1%) stddev-sans-first:1909.82 13:41:20 INFO - PROCESS | 1985 | Values: 320.6 324.4 327.1 331.3 335.0 6741.9 6767.7 6773.4 6774.1 6803.0 6627.3 6655.2 6679.6 6697.0 6698.5 3893.9 4305.6 4813.3 4969.3 5001.2 4918.6 4946.9 4975.7 4987.8 5007.5 4915.2 4924.8 4930.1 4933.5 4946.2 3965.9 4923.5 4940.0 4945.0 4959.2 4205.7 4207.9 4216.9 4224.7 4246.3 5945.3 6336.8 6389.6 6489.9 6511.0 5822.6 5870.7 5875.5 5900.2 5910.0 7141.9 7164.0 7174.1 7175.6 7193.6 4740.6 4741.0 4742.1 4747.5 4748.1 7552.7 7574.4 7589.1 7593.4 7595.6 3419.3 3815.6 4285.9 4627.2 4825.7 4710.6 4718.2 4719.5 4722.0 4742.0 4638.5 5647.2 5664.3 5669.1 5679.0 5796.0 7204.2 7222.3 7246.1 7273.7 1365.8 1641.7 1659.4 1661.5 1664.7 1015.6 1057.3 1059.6 1069.7 1073.8 6717.6 6729.8 6737.4 6748.4 6760.4 7505.7 7518.3 7533.8 7538.5 7559.7 5787.0 6566.1 6606.4 6775.4 6797.4 3829.5 3967.4 4003.2 4017.4 4019.5 7889.6 7901.3 7929.2 7936.1 7941.9 7589.4 7824.8 7828.2 7832.5 7882.0 7674.1 7941.3 7984.2 7988.6 8017.0 7587.7 7616.8 7652.2 7652.7 7667.8 7500.4 7510.8 7522.0 7522.1 7543.7 7591.6 7913.0 7963.2 8008.6 8016.1 4591.7 4596.7 4629.6 4633.6 4636.1 7537.7 7583.2 7586.7 7592.5 7601.0 5503.6 7300.9 7315.0 7326.0 7330.5 5967.3 7014.5 7239.1 7271.9 7325.9 6995.9 7060.4 7074.5 7081.4 7124.3 7232.4 7262.8 7266.0 7280.7 7294.4 7106.2 7143.7 7146.4 7149.9 7193.0 13:41:20 INFO - PROCESS | 1985 | 13:41:20 INFO - PROCESS | 1985 | [#5] yui.html Cycles:180 Average:17684.00 Median:654.76 stddev:24755.46 (3780.8%) stddev-sans-first:24791.77 13:41:20 INFO - PROCESS | 1985 | Values: 624.8 652.1 656.7 684.0 727.9 14618.0 14812.6 14848.6 14867.6 14878.2 11029.4 13400.6 13404.2 13486.6 15502.4 841.4 855.8 855.9 857.6 857.6 697.9 826.5 853.7 866.3 869.4 909.5 915.3 915.6 917.4 920.7 904.5 911.0 912.8 913.7 914.6 662.1 669.7 674.1 677.1 677.8 15174.5 15250.5 15291.5 15305.6 15357.5 12402.4 12445.8 12469.8 12481.3 12525.2 9951.1 10014.9 10171.3 10176.2 10188.7 3408.3 3455.9 3485.3 3548.5 3548.6 54761.2 83646.0 84849.2 85129.6 86600.6 9223.5 9298.6 9309.8 9318.4 9431.0 16713.7 20062.5 20756.4 20803.7 20855.7 7182.1 7205.1 7383.6 7391.4 7487.3 4004.3 4026.4 4158.4 4164.4 4174.8 3531.4 3573.8 3573.8 3578.5 3591.0 641.8 654.6 655.0 658.1 658.8 556.4 577.7 590.5 594.9 595.4 7398.8 7977.8 8040.9 8235.5 8343.6 499.3 523.4 563.5 602.1 618.9 3761.1 3785.7 3798.0 3835.1 3875.7 87274.1 87874.0 88462.0 88647.6 89731.7 71203.6 73344.3 73558.0 74332.0 74979.0 48017.5 57964.4 68353.3 69209.7 70824.3 7547.1 7655.0 7655.5 7720.2 7907.6 49765.5 50064.0 50880.5 50957.7 51222.0 66612.3 66939.0 67584.7 68490.7 68915.0 8815.5 9012.6 9611.7 9636.5 9741.9 10139.3 10774.9 11599.4 12126.8 13267.8 11277.3 11301.8 11407.1 11907.5 12359.9 11374.9 11730.7 11811.2 11815.7 11839.5 10886.7 11341.4 11603.9 11614.9 11763.4 9522.4 9711.8 9838.4 9899.7 9931.6 8765.7 8927.4 9253.4 9547.8 9713.4 13:41:20 INFO - PROCESS | 1985 | -------- Summary: end -------- 13:41:20 INFO - PROCESS | 1985 | 13:41:21 INFO - TEST-INFO | 1985: exit 0 13:41:21 INFO - TEST-OK | dromaeo_css | took 1110675ms 13:41:21 INFO - TEST-START | kraken 13:41:21 INFO - operating with platform_type : mac_ 13:41:21 INFO - Initialising browser for kraken test... 13:41:21 INFO - TEST-INFO | started process 1990 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpYAjG4Z/profile http://localhost:56108/getInfo.html) 13:41:24 INFO - PROCESS | 1990 | __metrics Screen width/height:1600/1200 13:41:24 INFO - PROCESS | 1990 | colorDepth:24 13:41:24 INFO - PROCESS | 1990 | Browser inner width/height: 1024/689 13:41:24 INFO - PROCESS | 1990 | __metrics 13:41:24 ERROR - PROCESS | 1990 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:41:24 INFO - TEST-INFO | 1990: exit 0 13:41:24 INFO - Browser initialized. 13:41:24 INFO - Running cycle 1/1 for kraken test... 13:41:24 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpYAjG4Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:36 INFO - PROCESS | 1993 | RSS: Main: 255557632 13:41:36 INFO - PROCESS | 1993 | 13:41:39 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56108/tests/kraken/driver.html?testName=audio-beat-detection) 13:41:40 INFO - PROCESS | 1993 | RSS: Main: 268312576 13:41:40 INFO - PROCESS | 1993 | 13:41:43 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56108/tests/kraken/driver.html?testName=audio-dft) 13:41:43 INFO - PROCESS | 1993 | RSS: Main: 276455424 13:41:43 INFO - PROCESS | 1993 | 13:41:47 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56108/tests/kraken/driver.html?testName=audio-fft) 13:41:47 INFO - PROCESS | 1993 | RSS: Main: 280682496 13:41:47 INFO - PROCESS | 1993 | 13:41:49 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56108/tests/kraken/driver.html?testName=audio-oscillator) 13:41:50 INFO - PROCESS | 1993 | RSS: Main: 283062272 13:41:50 INFO - PROCESS | 1993 | 13:41:52 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56108/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:41:53 INFO - PROCESS | 1993 | RSS: Main: 283992064 13:41:53 INFO - PROCESS | 1993 | 13:41:55 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56108/tests/kraken/driver.html?testName=imaging-darkroom) 13:41:56 INFO - PROCESS | 1993 | RSS: Main: 282783744 13:41:56 INFO - PROCESS | 1993 | 13:41:59 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56108/tests/kraken/driver.html?testName=imaging-desaturate) 13:41:59 INFO - PROCESS | 1993 | RSS: Main: 282628096 13:41:59 INFO - PROCESS | 1993 | 13:42:02 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56108/tests/kraken/driver.html?testName=json-parse-financial) 13:42:03 INFO - PROCESS | 1993 | RSS: Main: 282775552 13:42:03 INFO - PROCESS | 1993 | 13:42:05 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56108/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:42:05 INFO - PROCESS | 1993 | RSS: Main: 284278784 13:42:05 INFO - PROCESS | 1993 | 13:42:07 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56108/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:42:08 INFO - PROCESS | 1993 | RSS: Main: 284332032 13:42:08 INFO - PROCESS | 1993 | 13:42:10 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56108/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:42:10 INFO - PROCESS | 1993 | RSS: Main: 283234304 13:42:10 INFO - PROCESS | 1993 | 13:42:13 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:42:14 INFO - PROCESS | 1993 | RSS: Main: 283955200 13:42:14 INFO - PROCESS | 1993 | 13:42:16 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:42:17 INFO - PROCESS | 1993 | RSS: Main: 282681344 13:42:17 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:56108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56108/tests/kraken/driver.html?testName=ai-astar) 13:42:19 INFO - PROCESS | 1993 | RSS: Main: 285937664 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | __start_tp_report 13:42:19 INFO - PROCESS | 1993 | _x_x_mozilla_page_load 13:42:19 INFO - PROCESS | 1993 | _x_x_mozilla_page_load_details 13:42:19 INFO - PROCESS | 1993 | |i|pagename|runs| 13:42:19 INFO - PROCESS | 1993 | |0;ai-astar;103;139;110;159;177;126;113;117;114;116 13:42:19 INFO - PROCESS | 1993 | |1;audio-beat-detection;161;156;159;152;123;144;146;168;178;164 13:42:19 INFO - PROCESS | 1993 | |2;audio-dft;193;201;270;261;204;216;272;232;201;202 13:42:19 INFO - PROCESS | 1993 | |3;audio-fft;67;68;74;114;71;87;81;85;127;59 13:42:19 INFO - PROCESS | 1993 | |4;audio-oscillator;82;83;119;81;81;91;119;80;81;114 13:42:19 INFO - PROCESS | 1993 | |5;imaging-gaussian-blur;133;95;96;93;90;92;85;92;108;92 13:42:19 INFO - PROCESS | 1993 | |6;imaging-darkroom;95;97;142;96;95;97;96;95;94;96 13:42:19 INFO - PROCESS | 1993 | |7;imaging-desaturate;92;92;89;92;99;93;113;151;154;104 13:42:19 INFO - PROCESS | 1993 | |8;json-parse-financial;59;58;56;58;56;59;59;67;61;58 13:42:19 INFO - PROCESS | 1993 | |9;json-stringify-tinderbox;62;67;72;67;78;65;74;82;98;98 13:42:19 INFO - PROCESS | 1993 | |10;stanford-crypto-aes;87;86;85;85;87;84;87;84;88;88 13:42:19 INFO - PROCESS | 1993 | |11;stanford-crypto-ccm;133;127;155;134;129;121;145;134;134;147 13:42:19 INFO - PROCESS | 1993 | |12;stanford-crypto-pbkdf2;130;141;147;175;140;132;144;143;142;147 13:42:19 INFO - PROCESS | 1993 | |13;stanford-crypto-sha256-iterative;65;68;69;70;86;97;93;95;94;75 13:42:19 INFO - PROCESS | 1993 | __end_tp_report 13:42:19 INFO - PROCESS | 1993 | __start_cc_report 13:42:19 INFO - PROCESS | 1993 | _x_x_mozilla_cycle_collect,880 13:42:19 INFO - PROCESS | 1993 | __end_cc_report 13:42:19 INFO - PROCESS | 1993 | __startTimestamp1456436539397__endTimestamp 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | ------- Summary: start ------- 13:42:19 INFO - PROCESS | 1993 | Number of tests: 14 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#0] ai-astar Cycles:10 Average:127.40 Median:121.50 stddev:23.85 (19.6%) stddev-sans-first:23.60 13:42:19 INFO - PROCESS | 1993 | Values: 103.0 139.0 110.0 159.0 177.0 126.0 113.0 117.0 114.0 116.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:160.00 stddev:15.15 (9.5%) stddev-sans-first:15.92 13:42:19 INFO - PROCESS | 1993 | Values: 161.0 156.0 159.0 152.0 123.0 144.0 146.0 168.0 178.0 164.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#2] audio-dft Cycles:10 Average:225.20 Median:224.00 stddev:31.28 (14.0%) stddev-sans-first:30.93 13:42:19 INFO - PROCESS | 1993 | Values: 193.0 201.0 270.0 261.0 204.0 216.0 272.0 232.0 201.0 202.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#3] audio-fft Cycles:10 Average:83.30 Median:72.50 stddev:21.61 (29.8%) stddev-sans-first:22.10 13:42:19 INFO - PROCESS | 1993 | Values: 67.0 68.0 74.0 114.0 71.0 87.0 81.0 85.0 127.0 59.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:81.00 stddev:17.06 (21.1%) stddev-sans-first:17.61 13:42:19 INFO - PROCESS | 1993 | Values: 82.0 83.0 119.0 81.0 81.0 91.0 119.0 80.0 81.0 114.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#5] imaging-gaussian-blur Cycles:10 Average:97.60 Median:92.00 stddev:13.75 (14.9%) stddev-sans-first:6.22 13:42:19 INFO - PROCESS | 1993 | Values: 133.0 95.0 96.0 93.0 90.0 92.0 85.0 92.0 108.0 92.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:96.00 stddev:14.68 (15.3%) stddev-sans-first:15.45 13:42:19 INFO - PROCESS | 1993 | Values: 95.0 97.0 142.0 96.0 95.0 97.0 96.0 95.0 94.0 96.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#7] imaging-desaturate Cycles:10 Average:107.90 Median:92.00 stddev:24.59 (26.7%) stddev-sans-first:25.40 13:42:19 INFO - PROCESS | 1993 | Values: 92.0 92.0 89.0 92.0 99.0 93.0 113.0 151.0 154.0 104.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:3.14 (5.3%) stddev-sans-first:3.33 13:42:19 INFO - PROCESS | 1993 | Values: 59.0 58.0 56.0 58.0 56.0 59.0 59.0 67.0 61.0 58.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#9] json-stringify-tinderbox Cycles:10 Average:76.30 Median:76.00 stddev:12.94 (17.0%) stddev-sans-first:12.64 13:42:19 INFO - PROCESS | 1993 | Values: 62.0 67.0 72.0 67.0 78.0 65.0 74.0 82.0 98.0 98.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.58 13:42:19 INFO - PROCESS | 1993 | Values: 87.0 86.0 85.0 85.0 87.0 84.0 87.0 84.0 88.0 88.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:134.00 stddev:10.21 (7.6%) stddev-sans-first:10.78 13:42:19 INFO - PROCESS | 1993 | Values: 133.0 127.0 155.0 134.0 129.0 121.0 145.0 134.0 134.0 147.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:143.50 stddev:12.24 (8.5%) stddev-sans-first:11.87 13:42:19 INFO - PROCESS | 1993 | Values: 130.0 141.0 147.0 175.0 140.0 132.0 144.0 143.0 142.0 147.0 13:42:19 INFO - PROCESS | 1993 | 13:42:19 INFO - PROCESS | 1993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.20 Median:89.50 stddev:12.98 (14.5%) stddev-sans-first:12.37 13:42:19 INFO - PROCESS | 1993 | Values: 65.0 68.0 69.0 70.0 86.0 97.0 93.0 95.0 94.0 75.0 13:42:19 INFO - PROCESS | 1993 | -------- Summary: end -------- 13:42:19 INFO - PROCESS | 1993 | 13:42:20 INFO - TEST-INFO | 1993: exit 0 13:42:20 INFO - TEST-OK | kraken | took 58715ms 13:42:20 INFO - SUITE-END | took 1169s 13:42:20 INFO - Completed test suite (00:19:29) 13:42:20 INFO - Working with test: dromaeo_css 13:42:20 INFO - Generating results file: dromaeo_css 13:42:20 INFO - Working with test: kraken 13:42:20 INFO - Generating results file: kraken 13:42:20 INFO - javascript benchmark 13:42:20 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:42:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 13:42:20 INFO - process_Request line: dromaeo_css 7405.24 graph.html#tests=[[72,64,61]] 13:42:20 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:42:20 INFO - process_Request line: kraken 1572.60 graph.html#tests=[[232,64,61]] 13:42:20 INFO - RETURN: dromaeo_css: 7405.24 13:42:20 INFO - RETURN: kraken: 1572.60 13:42:20 INFO - javascript benchmark 13:42:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2925.4587901238274, 3530.505729197913, 3547.8048707321104, 3553.4847447120183, 3587.426011838106, 4457.331400289958, 4683.976580117099, 5016.896282817779, 5742.196092547047, 5809.302883653957, 5625.915611265835, 5698.430156984299, 5746.0, 5842.2989241291, 5930.762769489215, 5177.068127737015, 5240.633155679104, 5307.708076055816, 5313.628046036779, 5322.627416080876, 5222.242774797652, 5239.52844244018, 5341.679499230039, 5372.838814835562, 5399.5680345572455, 4491.820327186909, 5137.3064636274, 5205.427402985669, 5231.738413079331, 5247.606429517801, 4223.556526564697, 5169.689818610896, 5204.843854684365, 5206.5314121729225, 5214.608904332153, 5156.381234251914, 5180.6373553851245, 5207.791688332462, 5211.5830733541225, 5214.0, 5370.355557333106, 5550.0, 5611.102223644198, 5720.2849643794525, 5724.513416359614, 6182.84542886427, 6185.41238582334, 6200.100985357098, 6204.47261982732, 6207.782727604557, 6204.255489341263, 6241.095041219043, 6263.843403914893, 6268.09112678659, 6270.937290627081, 4889.266610008492, 5735.168400581934, 5775.018246897996, 5796.797112101056, 5802.65184088956, 6240.344763799736, 6281.466075383552, 6298.968505157445, 6309.337519560472, 6317.210348706411, 6068.4538391544975, 6204.007358822567, 6219.0, 6220.911340515482, 6232.3144454110015, 6224.906626400608, 6227.595206311576, 6298.496120310364, 6302.842428939313, 6306.274778400542, 6060.090986351995, 6113.816585502442, 6184.567080304336, 6186.783462578878, 6186.938130618636, 6088.417011577022, 6114.449699527064, 6219.689015549205, 6245.313015568284, 6265.342139075331, 4895.510448955076, 4903.945651684905, 4934.8766280843265, 4937.925931111036, 4979.45226025137, 4407.823687052546, 4441.800118994653, 4442.577955094261, 4451.799669014902, 4482.39487669167, 5630.634008789498, 5653.575981801381, 5774.422557744192, 5805.419458054161, 5848.5321174305955, 6206.162168107247, 6215.502759779297, 6269.185005949197, 6292.402221788922, 6295.370462953668, 5786.94213057864, 5807.82576522705, 5825.155352473867, 5857.648541087548, 5860.560457965669, 5292.655977361459, 5359.651622644516, 5420.0, 5424.864378390572, 5607.990561698934, 6337.302896681362, 6340.556161068773, 6355.428011478989, 6359.014352775327, 6361.268454127835, 6253.37466253371, 6261.843453913689, 6264.4048815364295, 6272.18461599989, 6280.120783090462, 5256.737163141904, 6189.473894718819, 6245.219347581552, 6304.7162877671535, 6314.905276420949, 6208.9689551551955, 6218.409251121137, 6226.533010024175, 6256.468200203034, 6257.4681152102585, 6249.500039996698, 6273.435390814849, 6279.591826531261, 6285.811425657238, 6293.811185664437, 5920.79277225295, 6018.187544681412, 6117.979653188298, 6127.3259941407305, 6157.692115394123, 6100.667974472981, 6114.246153692847, 6122.418370254819, 6150.630962142286, 6197.0, 5577.693226872399, 5626.127950167731, 5676.148577713376, 5678.261825962599, 5778.393268706894, 5847.561432892465, 6065.059915713072, 6119.715820550834, 6122.173506576555, 6162.352952940056, 5959.22530071088, 6034.818955431344, 6057.061155520902, 6067.180930574493, 6076.57463977535], "unit": "score", "name": "dojo.html", "value": 5676.44548181076}, {"lowerIsBetter": false, "replicates": [435.5448556258709, 483.7557033697983, 500.914844476439, 534.8287250920484, 591.9881602367956, 36691.4496282556, 37215.62784372155, 37344.62655373445, 37350.252994940085, 37367.06582335443, 34325.82837085811, 37247.068823279435, 38318.61681383185, 38439.80780096095, 38753.8373848785, 9300.348975571713, 9455.952720236424, 9507.286953478482, 9520.666776662818, 9579.377340472882, 9387.389819661734, 9569.95215023924, 9594.088561586637, 9625.22998160149, 9653.5173241338, 9595.184409325217, 9621.08599683029, 9642.084002019832, 9658.034196580356, 9658.420494770302, 9550.235981121494, 9625.374350667184, 9639.469829159394, 9671.177949874269, 9723.02769723029, 9448.95275523618, 9522.571484283224, 9579.425234485952, 9584.137427631476, 9594.568244428947, 36917.63082369169, 37277.0, 37496.06259843498, 37594.62405375966, 37603.43594846079, 3182.347618738153, 3182.9522557161663, 3333.799972001688, 3371.561696979377, 3584.8207589620674, 27519.58720619192, 27926.301842453897, 28091.57862632062, 28507.57238641422, 28847.56728649051, 2774.8612569371653, 2781.707920668341, 2849.2591926099158, 2877.438899414615, 2980.9850950745326, 408204.0, 491870.0812991896, 492070.0, 493540.0, 493723.5313823444, 35147.0, 44706.55293447024, 44816.77591612021, 62618.0, 63644.727105457634, 43247.56752432435, 43585.56414435879, 43658.781706091904, 43739.78130109393, 43844.12311753747, 12844.0, 15085.24573771307, 15163.848361516464, 15276.38894444232, 15366.462173823862, 12085.45615447307, 12188.756224875453, 12295.385230738428, 12385.009199264037, 12402.19385739924, 14283.571492855232, 14493.0, 14500.492482763264, 14538.927305363406, 14631.780523292158, 6178.907316390258, 6256.781012664626, 6276.340984196685, 6291.276503202099, 6307.747690092437, 898.714837781965, 976.8144052629978, 981.6760469045198, 985.3102828020415, 1077.4612693653173, 26821.927122915255, 28730.42539149247, 28733.56899646507, 29110.708892911225, 29465.0, 1082.8592283003318, 1085.9402732849612, 1100.070440477795, 1154.6074334726234, 1160.23424539805, 14580.125192488485, 14689.632759180893, 14740.926295368668, 14842.554723358317, 15142.54572362831, 515777.0, 516640.4167979136, 518472.0, 519705.0, 523891.0, 55310.0, 55415.72292138594, 55959.0, 56018.719906400205, 56161.87676246452, 1351.3175846197607, 1369.3700897587023, 1384.6746014686541, 1392.2273138408282, 1399.5381524097227, 28162.732677029173, 28163.71836281693, 28275.15174544767, 28340.0, 28526.57210141808, 47839.521604783506, 47876.0, 47964.7601761989, 48245.5175448241, 48397.5160248393, 458711.0, 461711.0, 462978.0, 463067.0, 463618.0, 26746.86626566855, 32243.35513289674, 41082.1783564333, 42501.93745156396, 43790.68627941167, 40566.39150412805, 41352.79323603363, 41752.74741757752, 42261.0, 42368.36447453229, 28221.373055702214, 34111.65888341085, 35303.47044794279, 35602.575896963834, 35858.8207058963, 33175.004749857544, 33194.336113278085, 35206.82396588001, 35310.47034294539, 35987.64012359843, 35829.82085089558, 35864.82067589645, 36421.45367819432, 37015.0, 37047.073823154635, 29426.558601620563, 31646.525302120026, 31653.050408487783, 31701.04896853098, 31823.68176318207, 23789.881050594635, 23867.522649546565, 24013.91937362788, 24355.0, 24462.0], "unit": "score", "name": "ext.html", "value": 18662.74937897211}, {"lowerIsBetter": false, "replicates": [343.54308769336785, 347.64988676546545, 349.3990336621012, 354.374528956392, 354.57982290985166, 18453.815461845377, 18766.812331876677, 19268.036598170107, 19272.421827345202, 19634.70547941782, 19346.51633709158, 19685.704714429296, 20066.996650167504, 20348.491287717814, 20494.590108197826, 5574.749136288867, 5863.973804584202, 5901.734421951001, 5903.704814759266, 5909.231799866033, 4163.2298024865495, 5712.628679135863, 6088.269407671086, 6366.872662546746, 6379.489640828746, 6278.937210627881, 6306.211723534559, 6318.178636777213, 6320.873582528347, 6327.715252813611, 6071.1803906472505, 6404.583702059374, 6420.807375778734, 6469.83825404364, 6478.0, 5387.730613469311, 5450.700211488366, 5492.450754924515, 5525.198846167324, 5538.307711536058, 23707.644385334235, 24292.392690182885, 24363.634545481833, 24411.87794061036, 24437.38906527333, 1764.9382271620432, 2054.7226124473154, 2181.182056728727, 2617.882195301197, 2845.6869744328105, 9300.395474294217, 9680.370775899544, 9824.164945979528, 9842.852357214648, 14529.491467798576, 1657.627033917371, 1674.7990241171137, 1700.5153531243536, 1755.965335760351, 1804.0979510244877, 79520.60239698822, 99646.5017674907, 101535.0, 103643.4817825906, 104755.0, 11044.226904116635, 11063.778724425467, 11067.280626759235, 11131.777364452666, 11155.27490713101, 13199.0, 13240.801387979189, 13242.668933276746, 13277.605851385466, 13382.063255572211, 6207.131001659771, 8291.875621865676, 8377.37169712274, 8416.957915210507, 8542.530160841214, 6681.799546013627, 7918.920810791818, 8086.555239461768, 8595.226429621363, 8725.996510401385, 3595.4606808978338, 4350.129974005212, 4368.235558777201, 4400.9559904401185, 4442.444694413199, 1754.9912250438665, 1780.261191605495, 1814.845738112249, 1827.2782251010776, 1845.8061903499938, 834.3950635789005, 900.2392977933636, 940.7234492528098, 969.888462826784, 989.302541708094, 18312.450626481226, 18942.810571894104, 18943.336983205798, 19170.329038483866, 19421.611567768567, 936.279065119854, 938.474454305591, 956.6269155029544, 977.3305285879195, 1012.8126296635146, 9968.102870741668, 10393.428361440043, 10495.685129446128, 10517.52671129801, 10540.578376864993, 456921.0, 523401.0, 532436.0, 535982.0, 645360.0, 104587.47706261573, 106131.0, 127546.0, 132432.0, 135310.0, 990.3414229537422, 1004.2167109654481, 1034.4775888176573, 1036.0571879589538, 1041.375174895072, 17607.0, 17607.20767565488, 17807.643847122727, 18248.0, 18419.355322563646, 49856.00287994292, 50042.0, 52790.0, 52969.94060118699, 53599.0, 68673.0, 69206.30793691998, 69646.65176674085, 69825.65087174531, 73916.63041684758, 7744.954431151722, 7936.127026027248, 7957.1644977276555, 7980.84038319242, 8115.59422028908, 12682.87317126817, 12773.425195866394, 12934.0, 13224.0, 13392.129511581716, 9520.619175232912, 11372.0, 11661.416929153678, 11709.414529273332, 11753.471093800628, 9382.530873456164, 11346.149038821955, 11371.43142842871, 11413.714657133638, 11749.88250117488, 7811.8286553622, 11565.479553419947, 11595.072394208275, 11952.163348565864, 12042.578509752117, 7943.285104340637, 7956.92043079585, 7995.0, 8050.355971522147, 8314.127016663164, 8619.91380086191, 8836.558172091241, 10252.282340236112, 10853.294535855144, 11530.711732206762], "unit": "score", "name": "jquery.html", "value": 9253.897121988872}, {"lowerIsBetter": false, "replicates": [1394.6373942774878, 1516.226724370571, 1715.2795825753183, 1867.0, 1904.1526520698294, 7866.449348545604, 8519.659213631447, 8587.699430519933, 8787.95606021969, 8804.559772011398, 8606.440581362207, 8662.003869555003, 8706.651733930636, 8725.127487251271, 8729.91270087299, 2439.402346425128, 2440.6949131358624, 2466.3957330454064, 2467.8889449974795, 2468.0004598137784, 2399.7524381844128, 2442.829001969863, 2450.3751543356507, 2454.631805229212, 2458.397692565315, 2452.1172377943926, 2457.7542245775458, 2467.0, 2467.605183170693, 2473.6907886514186, 2424.59994100974, 2444.718857331412, 2449.1795248591743, 2457.508498300347, 2467.938301542458, 2027.2701827342146, 2388.665586817847, 2411.3248290478696, 2414.2033129067368, 2427.077710470028, 8722.563871806384, 8729.170728780819, 8747.606357713854, 8762.605682744228, 8788.692395766182, 5212.29633999409, 5298.417174110845, 5343.973280133613, 5344.011357898801, 5430.91853622196, 3012.472817256993, 3593.892183234481, 3671.8531258749617, 3692.3538380783257, 3732.757370770891, 859.8882145321131, 1048.1195795531714, 1076.2358725305044, 1630.3723066619318, 1666.1086318819373, 11483.712907177303, 11537.0, 11595.536178552848, 11628.709282268012, 11652.883471165265, 4587.7017993830295, 4650.000249946278, 4717.834875779331, 4733.195356789354, 4783.641226907996, 9145.0397708241, 9173.495457749754, 9179.77050573741, 9201.171894529525, 9207.17135457812, 4583.0, 4598.908021839611, 5233.371995360581, 5376.220448035091, 5388.625900395374, 4445.288753799441, 4817.0606731686985, 4885.022995400934, 4892.681975671641, 5021.6735912165595, 3708.5364329458816, 3746.868859589901, 3794.5636251830842, 3811.294910441577, 3816.0078379620945, 1186.0, 1192.117832803719, 1197.3713800254936, 1200.3338147328316, 1202.464903118104, 1336.9732605347838, 1340.9396577154052, 1360.4286199796109, 1365.5661555366826, 1377.9104358216684, 8047.597620118971, 8211.712590059438, 8246.422750407533, 8269.131741167212, 8294.543800091053, 504.4400715206118, 509.8750806052541, 510.9540141387293, 516.9534741873249, 519.631061946015, 5975.790847320323, 6089.695515224221, 6094.055421409688, 6138.508919286535, 6176.166217560572, 10113.949430252802, 10384.169266458664, 10405.271630985759, 10406.687799366031, 10494.160467162608, 10133.08802207805, 10273.0, 10363.533640986174, 10388.792224155626, 10437.843432348522, 8147.307478864363, 8245.13426090264, 8254.958725206456, 8303.211194936472, 8316.41785075039, 7926.920730792618, 7966.083900351302, 7983.640736166771, 7996.280334769898, 8014.879776803236, 9185.908140918506, 9354.859677104712, 9412.623495060121, 9501.809963800824, 9599.184069353903, 9682.806343872942, 9815.901840981498, 9847.212223022285, 9875.506224688881, 9914.504274786375, 6762.661866906733, 7130.964345178241, 7354.264573542603, 7386.926130738624, 7489.812754680958, 8044.798880028046, 8116.553589552395, 8149.266566009088, 8178.100408955129, 8187.631556579849, 7129.928700712927, 7221.169565500035, 7248.746293879689, 7347.302006309392, 7394.815129621587, 7083.327083927019, 7153.320434558708, 7156.964215178891, 7186.1376634804155, 7232.276772322725, 7574.204708505527, 7649.082110146818, 7653.540787552764, 7656.923430765621, 7683.577403242875, 6849.1438570178725, 6939.965300173467, 6941.305869413019, 6946.235914049349, 6979.127609048869, 6888.173419189729, 7047.823804404931, 7052.012718219556, 7069.9646501767165, 7080.575165490087], "unit": "score", "name": "mootools.html", "value": 4788.571126246679}, {"lowerIsBetter": false, "replicates": [320.55602989859045, 324.39014652453386, 327.0613339715018, 331.30591410993975, 334.9933001339972, 6741.865162696743, 6767.695453704583, 6773.356531129547, 6774.051632771416, 6803.0, 6627.304133066031, 6655.201375834895, 6679.5658282211625, 6696.952886436672, 6698.531102822804, 3893.8831835044853, 4305.5909688579695, 4813.326134341195, 4969.25461180824, 5001.199808030716, 4918.581920536759, 4946.897568533377, 4975.7263350515705, 4987.775550100254, 5007.549320561149, 4915.213565829468, 4924.753762311888, 4930.087933732253, 4933.481984391641, 4946.159152944008, 3965.861194858166, 4923.458419573844, 4939.975300123512, 4944.975275123619, 4959.181735013701, 4205.726627769216, 4207.91584168318, 4216.894577635553, 4224.683148763825, 4246.299360605496, 5945.316288626776, 6336.841578960563, 6389.584676995981, 6489.902651460232, 6510.967445162792, 5822.621529600562, 5870.73581688825, 5875.529957603424, 5900.232969713909, 5909.9704501477645, 7141.89287160693, 7164.0, 7174.1032370953635, 7175.641217939135, 7193.640317984132, 4740.644451666139, 4740.952590474086, 4742.146413645542, 4747.477777444478, 4748.0978614063215, 7552.735654252075, 7574.394048476164, 7589.089309282866, 7593.354564861993, 7595.620218989028, 3419.26485805553, 3815.599362066943, 4285.928517870532, 4627.236505976476, 4825.662203645781, 4710.62315014798, 4718.2214934536105, 4719.480857105716, 4722.0, 4742.0, 4638.536146385334, 5647.237622920935, 5664.320281566238, 5669.121286200563, 5679.034564124109, 5796.0, 7204.207537170907, 7222.313880181375, 7246.130464344313, 7273.745418910313, 1365.7503384403358, 1641.720907445737, 1659.4192032788428, 1661.5264649574813, 1664.6837100950781, 1015.6140666546665, 1057.3021805608262, 1059.6397224943403, 1069.668402795136, 1073.849661047454, 6717.56335838169, 6729.798106056826, 6737.3599508046655, 6748.358905903931, 6760.391564759196, 7505.737299194502, 7518.28576285252, 7533.849323013509, 7538.472306938571, 7559.697612095564, 5786.958347497491, 6566.146400967844, 6606.405423511907, 6775.390214880685, 6797.388235058868, 3829.463875057494, 3967.4247234150885, 4003.179348233605, 4017.417474466186, 4019.537753158366, 7889.644965976545, 7901.2888840003525, 7929.20707929214, 7936.127026027132, 7941.880871786928, 7589.43079269046, 7824.84350313002, 7828.178041305695, 7832.451728378959, 7881.960590197013, 7674.079110506775, 7941.324987376138, 7984.20157984197, 7988.640511177011, 8017.0, 7587.734429294948, 7616.80957976055, 7652.196519365387, 7652.73215437457, 7667.808304792202, 7500.399968002655, 7510.849783004419, 7522.0, 7522.097348318237, 7543.73596924105, 7591.62041897914, 7913.0, 7963.243491868263, 8008.639611217625, 8016.1182269949095, 4591.747453889934, 4596.724196548218, 4629.606483448944, 4633.6368452090355, 4636.095961287517, 7537.698492060256, 7583.2416758323725, 7586.658600362886, 7592.468527203264, 7600.961995189989, 5503.559715222693, 7300.890486642598, 7315.0, 7325.963370183328, 7330.523515971445, 5967.283925928917, 7014.473914456335, 7239.095113110861, 7271.927280727336, 7325.926740732524, 6995.895061573979, 7060.399866011241, 7074.540154889915, 7081.398081163159, 7124.287571242834, 7232.421406287379, 7262.818429539304, 7266.0, 7280.672369743268, 7294.379977701955, 7106.218315985341, 7143.678534465857, 7146.392556632536, 7149.892751608834, 7193.0289410930945], "unit": "score", "name": "prototype.html", "value": 5230.344365953671}, {"lowerIsBetter": false, "replicates": [624.7532224771215, 652.1163823019808, 656.704482982658, 683.9658017099147, 727.9126504819423, 14618.0, 14812.555623331318, 14848.628784280385, 14867.55397338079, 14878.18170000651, 11029.393383363911, 13400.59798206053, 13404.195748255112, 13486.595402137951, 15502.379904803822, 841.4236248170023, 855.7903313688124, 855.8844555984956, 857.5926434943415, 857.618359829876, 697.9092717946685, 826.4875777018257, 853.6670698427619, 866.3459088388258, 869.4174902815129, 909.4906852162777, 915.3318077803208, 915.5605309451435, 917.3899356927635, 920.6593560382668, 904.479924043671, 910.9590068446903, 912.803747194353, 913.684778751333, 914.634146341462, 662.1292999705372, 669.6651674162919, 674.103442421583, 677.0757915445431, 677.837319043431, 15174.468893588672, 15250.466233681878, 15291.464798732102, 15305.61735956599, 15357.462488812838, 12402.379881005914, 12445.813312800316, 12469.812952805714, 12481.251124932533, 12525.185862918881, 9951.104400603981, 10014.89985100147, 10171.288009839314, 10176.185905127571, 10188.694339169837, 3408.3183363327435, 3455.9308813823836, 3485.2855164691177, 3548.538689970313, 3548.6451354864566, 54761.1785823213, 83646.0, 84849.15150848475, 85129.57435212785, 86600.56699716524, 9223.538823058954, 9298.628054877729, 9309.813803723888, 9318.440893546409, 9430.95284523573, 16713.749293760604, 20062.498437538885, 20756.377308680763, 20803.68794468084, 20855.687164692543, 7182.141701714676, 7205.099362579677, 7383.593902335423, 7391.408687305003, 7487.3261406473675, 4004.2828675384485, 4026.375911733686, 4158.376243563429, 4164.37534369847, 4174.770387628649, 3531.434970404723, 3573.7855728656364, 3573.8391772370305, 3578.5347904772734, 3591.0304217861553, 641.7914177892204, 654.5581732330658, 654.9639769812611, 658.111549408295, 658.7760161545098, 556.4352182534731, 577.7255803493307, 590.5157770628044, 594.9048152295612, 595.4235469242144, 7398.779201431704, 7977.800554986172, 8040.919590804017, 8235.50586964784, 8343.624536895733, 499.2835281371244, 523.4033202149552, 563.4534501533506, 602.1269159718425, 618.904069869171, 3761.1161377076364, 3785.7096456643885, 3797.962020379761, 3835.079580900564, 3875.6511913927884, 87274.1272587266, 87874.0, 88462.0, 88647.55676221578, 89731.65402518968, 71203.6439817808, 73344.2665573348, 73558.0, 74332.0, 74979.0, 48017.519824802, 57964.42035579675, 68353.2911677202, 69209.65395172992, 70824.2917570828, 7547.076313181367, 7654.961725191339, 7655.46411751172, 7720.189380115232, 7907.56508392044, 49765.502344976085, 50064.0, 50880.491195087576, 50957.74521127371, 51222.0, 66612.33387666062, 66939.0, 67584.6620766893, 68490.65754671195, 68915.0, 8815.515146666994, 9012.63949442015, 9611.663591774533, 9636.518174091407, 9741.9025809741, 10139.290249682452, 10774.892251077703, 11599.420028998347, 12126.818097728365, 13267.800982985456, 11277.323360598062, 11301.773964520828, 11407.144464165054, 11907.464164112462, 12359.938200308941, 11374.94312528432, 11730.70673233176, 11811.173217874666, 11815.704607384883, 11839.467223974769, 10886.727831803952, 11341.376224307742, 11603.941980290045, 11614.941925290319, 11763.411829408666, 9522.428654280766, 9711.757206069904, 9838.409695418297, 9899.703008909744, 9931.553080111267, 8765.693200738198, 8927.419717718327, 9253.444793312154, 9547.809043818947, 9713.368631039242], "unit": "score", "name": "yui.html", "value": 6715.678678744473}], "name": "dromaeo_css", "value": 7405.243647093963}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [103.0, 139.0, 110.0, 159.0, 177.0, 126.0, 113.0, 117.0, 114.0, 116.0], "unit": "score", "name": "ai-astar", "value": 127.4}, {"lowerIsBetter": true, "replicates": [161.0, 156.0, 159.0, 152.0, 123.0, 144.0, 146.0, 168.0, 178.0, 164.0], "unit": "score", "name": "audio-beat-detection", "value": 155.1}, {"lowerIsBetter": true, "replicates": [193.0, 201.0, 270.0, 261.0, 204.0, 216.0, 272.0, 232.0, 201.0, 202.0], "unit": "score", "name": "audio-dft", "value": 225.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 74.0, 114.0, 71.0, 87.0, 81.0, 85.0, 127.0, 59.0], "unit": "score", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 119.0, 81.0, 81.0, 91.0, 119.0, 80.0, 81.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 93.1}, {"lowerIsBetter": true, "replicates": [133.0, 95.0, 96.0, 93.0, 90.0, 92.0, 85.0, 92.0, 108.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.6}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 142.0, 96.0, 95.0, 97.0, 96.0, 95.0, 94.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 100.3}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 89.0, 92.0, 99.0, 93.0, 113.0, 151.0, 154.0, 104.0], "unit": "score", "name": "imaging-desaturate", "value": 107.9}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 56.0, 58.0, 56.0, 59.0, 59.0, 67.0, 61.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [62.0, 67.0, 72.0, 67.0, 78.0, 65.0, 74.0, 82.0, 98.0, 98.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.3}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 85.0, 85.0, 87.0, 84.0, 87.0, 84.0, 88.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [133.0, 127.0, 155.0, 134.0, 129.0, 121.0, 145.0, 134.0, 134.0, 147.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.9}, {"lowerIsBetter": true, "replicates": [130.0, 141.0, 147.0, 175.0, 140.0, 132.0, 144.0, 143.0, 142.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 69.0, 70.0, 86.0, 97.0, 93.0, 95.0, 94.0, 75.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 81.2}], "name": "kraken", "value": 1572.6}]} 13:42:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1572.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7405.24"}}} 13:42:21 INFO - Return code: 0 13:42:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:42:21 ERROR - # TBPL SUCCESS # 13:42:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:42:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:42:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:42:21 INFO - 2016-02-25 13:42:21.108 screenresolution[1998:20087] starting screenresolution argv=screenresolution get 13:42:21 INFO - 2016-02-25 13:42:21.110 screenresolution[1998:20087] Display 0: 1600x1200x32@60 13:42:21 INFO - 2016-02-25 13:42:21.116 screenresolution[1999:20090] starting screenresolution argv=screenresolution list 13:42:21 INFO - Available Modes on Display 0 13:42:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:42:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:42:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:42:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:42:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:42:21 INFO - Intel Iris: 13:42:21 INFO - Chipset Model: Intel Iris 13:42:21 INFO - Type: GPU 13:42:21 INFO - Bus: Built-In 13:42:21 INFO - VRAM (Dynamic, Max): 1536 MB 13:42:21 INFO - Vendor: Intel (0x8086) 13:42:21 INFO - Device ID: 0x0a2e 13:42:21 INFO - Revision ID: 0x0009 13:42:21 INFO - Displays: 13:42:21 INFO - Display: 13:42:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:42:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:42:21 INFO - Display Serial Number: 1600x1200 60 13:42:21 INFO - Main Display: Yes 13:42:21 INFO - Mirror: Off 13:42:21 INFO - Online: Yes 13:42:21 INFO - Rotation: Supported 13:42:21 INFO - Return code: 0 13:42:21 INFO - Running post-action listener: _resource_record_post_action 13:42:21 INFO - Running post-run listener: _resource_record_post_run 13:42:22 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 28672; Write bytes: 709522944; Read time: 1; Write time: 1967 13:42:22 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391086592; Write bytes: 385999360; Read time: 29178; Write time: 719 13:42:22 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 28672; Write bytes: 302298112; Read time: 1; Write time: 1203 13:42:22 INFO - Running post-run listener: _upload_blobber_files 13:42:22 INFO - Blob upload gear active. 13:42:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:42:22 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:42:22 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:42:22 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:42:22 INFO - (blobuploader) - INFO - Open directory for files ... 13:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:42:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:26 INFO - (blobuploader) - INFO - Done attempting. 13:42:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:42:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:42:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:27 INFO - (blobuploader) - INFO - Done attempting. 13:42:27 INFO - (blobuploader) - INFO - Iteration through files over. 13:42:27 INFO - Return code: 0 13:42:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:42:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:42:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e52f7a03af92d3488ee9039cbc9816f2ddfb343f3a97bbb72d9936a3dbc2b0b67a719cf3f8ca756776577dba5fdbd541fece4ad523b97893b00e7d45162ec034", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73e45ec0b79edcd3d0a456a42de42fb07dc0b3c6f96d38c067051ea77167cb112422eab8d8a4b6414e8b79521cb231efaa5e988b5f3036c2d1c872ac9930a2dc"} 13:42:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:42:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:42:27 INFO - Contents: 13:42:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e52f7a03af92d3488ee9039cbc9816f2ddfb343f3a97bbb72d9936a3dbc2b0b67a719cf3f8ca756776577dba5fdbd541fece4ad523b97893b00e7d45162ec034", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73e45ec0b79edcd3d0a456a42de42fb07dc0b3c6f96d38c067051ea77167cb112422eab8d8a4b6414e8b79521cb231efaa5e988b5f3036c2d1c872ac9930a2dc"} 13:42:27 INFO - Running post-run listener: copy_logs_to_upload_dir 13:42:27 INFO - Copying logs to upload dir... 13:42:27 INFO - mkdir: /builds/slave/test/build/upload/logs 13:42:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.664165 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-25 13:42:27.197377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 13:42:27.200395) ========= 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.cuMvAH4rqt/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.brjdGkRrDr/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e52f7a03af92d3488ee9039cbc9816f2ddfb343f3a97bbb72d9936a3dbc2b0b67a719cf3f8ca756776577dba5fdbd541fece4ad523b97893b00e7d45162ec034", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73e45ec0b79edcd3d0a456a42de42fb07dc0b3c6f96d38c067051ea77167cb112422eab8d8a4b6414e8b79521cb231efaa5e988b5f3036c2d1c872ac9930a2dc"} build_url:https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/J0NHUyzmQUCGkcMjTljokA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e52f7a03af92d3488ee9039cbc9816f2ddfb343f3a97bbb72d9936a3dbc2b0b67a719cf3f8ca756776577dba5fdbd541fece4ad523b97893b00e7d45162ec034", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73e45ec0b79edcd3d0a456a42de42fb07dc0b3c6f96d38c067051ea77167cb112422eab8d8a4b6414e8b79521cb231efaa5e988b5f3036c2d1c872ac9930a2dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 13:42:27.226800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 13:42:27.227099) ========= 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.cuMvAH4rqt/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.brjdGkRrDr/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.005269 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 13:42:27.275500) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 13:42:27.275780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 13:42:27.276128) ========= ========= Total master_lag: 0.54 =========