builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0191 starttime: 1456957120.79 results: success (0) buildid: 20160302124322 builduid: 0041955e581348f8ba9d4f5f95b4cbf5 revision: 5ea9a54a24d60dc63df47c4f7f5231b66d8835c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.787319) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.787744) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.788052) ========= 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.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005567 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.811277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.811572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.833584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.834017) ========= 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.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005189 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.882681) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.882994) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.883344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:40.883617) ========= 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.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-03-02 14:18:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.60M=0.002s 2016-03-02 14:18:41 (6.60 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:41.053037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:41.053345) ========= 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.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.019351 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:41.101877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:41.102226) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ea9a54a24d60dc63df47c4f7f5231b66d8835c6 --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 5ea9a54a24d60dc63df47c4f7f5231b66d8835c6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-03-02 14:18:41,176 truncating revision to first 12 chars 2016-03-02 14:18:41,176 Setting DEBUG logging. 2016-03-02 14:18:41,176 attempt 1/10 2016-03-02 14:18:41,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ea9a54a24d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 14:18:41,788 unpacking tar archive at: fx-team-5ea9a54a24d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.852746 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:41.977070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:41.977467) ========= echo 5ea9a54a24d60dc63df47c4f7f5231b66d8835c6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5ea9a54a24d60dc63df47c4f7f5231b66d8835c6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 5ea9a54a24d60dc63df47c4f7f5231b66d8835c6 program finished with exit code 0 elapsedTime=0.004891 script_repo_revision: '5ea9a54a24d60dc63df47c4f7f5231b66d8835c6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:42.029622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:42.029997) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 14:18:42.043680) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-02 14:18:42.044071) ========= /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.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:18:42 INFO - MultiFileLogger online at 20160302 14:18:42 in /builds/slave/test 14:18:42 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 14:18:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:18:42 INFO - {'append_to_log': False, 14:18:42 INFO - 'base_work_dir': '/builds/slave/test', 14:18:42 INFO - 'blob_upload_branch': 'Fx-Team', 14:18:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:18:42 INFO - 'branch': 'Fx-Team', 14:18:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:18:42 INFO - 'config_files': ('talos/mac_config.py',), 14:18:42 INFO - 'default_actions': ('clobber', 14:18:42 INFO - 'read-buildbot-config', 14:18:42 INFO - 'download-and-extract', 14:18:42 INFO - 'populate-webroot', 14:18:42 INFO - 'create-virtualenv', 14:18:42 INFO - 'install', 14:18:42 INFO - 'run-tests'), 14:18:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:18:42 INFO - 'download_minidump_stackwalk': True, 14:18:42 INFO - 'download_symbols': 'ondemand', 14:18:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:18:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:18:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:18:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:18:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:18:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:18:42 INFO - 'installer_path': 'installer.exe', 14:18:42 INFO - 'log_level': 'info', 14:18:42 INFO - 'log_name': 'talos', 14:18:42 INFO - 'log_to_console': True, 14:18:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:18:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:18:42 INFO - 'opt_config_files': (), 14:18:42 INFO - 'pip_index': False, 14:18:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:18:42 INFO - 'cmd': ('bash', 14:18:42 INFO - '-c', 14:18:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:18:42 INFO - 'enabled': True, 14:18:42 INFO - 'halt_on_failure': False, 14:18:42 INFO - 'name': 'check_screen_resolution'},), 14:18:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:18:42 INFO - 'cmd': ('bash', 14:18:42 INFO - '-c', 14:18:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:18:42 INFO - 'enabled': True, 14:18:42 INFO - 'halt_on_failure': False, 14:18:42 INFO - 'name': 'check_screen_resolution'},), 14:18:42 INFO - 'run_cmd_checks_enabled': True, 14:18:42 INFO - 'sps_profile': False, 14:18:42 INFO - 'sps_profile_interval': 0, 14:18:42 INFO - 'suite': 'dromaeojs-e10s', 14:18:42 INFO - 'system_bits': '32', 14:18:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:18:42 INFO - 'title': 't-yosemite-r7-0191', 14:18:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:18:42 INFO - 'use_talos_json': True, 14:18:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:18:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:18:42 INFO - 'work_dir': 'build'} 14:18:42 INFO - ##### 14:18:42 INFO - ##### Running clobber step. 14:18:42 INFO - ##### 14:18:42 INFO - Running pre-action listener: _resource_record_pre_action 14:18:42 INFO - Running main action method: clobber 14:18:42 INFO - rmtree: /builds/slave/test/build 14:18:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:18:43 INFO - Running post-action listener: _resource_record_post_action 14:18:43 INFO - ##### 14:18:43 INFO - ##### Running read-buildbot-config step. 14:18:43 INFO - ##### 14:18:43 INFO - Running pre-action listener: _resource_record_pre_action 14:18:43 INFO - Running main action method: read_buildbot_config 14:18:43 INFO - Using buildbot properties: 14:18:43 INFO - { 14:18:43 INFO - "project": "", 14:18:43 INFO - "product": "firefox", 14:18:43 INFO - "script_repo_revision": "production", 14:18:43 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:18:43 INFO - "repository": "", 14:18:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:18:43 INFO - "buildid": "20160302124322", 14:18:43 INFO - "pgo_build": "False", 14:18:43 INFO - "basedir": "/builds/slave/test", 14:18:43 INFO - "buildnumber": 480, 14:18:43 INFO - "slavename": "t-yosemite-r7-0191", 14:18:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:18:43 INFO - "platform": "yosemite_r7", 14:18:43 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:18:43 INFO - "branch": "fx-team", 14:18:43 INFO - "repo_path": "integration/fx-team", 14:18:43 INFO - "revision": "5ea9a54a24d60dc63df47c4f7f5231b66d8835c6", 14:18:43 INFO - "stage_platform": "macosx64", 14:18:43 INFO - "builduid": "0041955e581348f8ba9d4f5f95b4cbf5", 14:18:43 INFO - "slavebuilddir": "test" 14:18:43 INFO - } 14:18:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:18:43 INFO - Running post-action listener: _resource_record_post_action 14:18:43 INFO - ##### 14:18:43 INFO - ##### Running download-and-extract step. 14:18:43 INFO - ##### 14:18:43 INFO - Running pre-action listener: _resource_record_pre_action 14:18:43 INFO - Running main action method: download_and_extract 14:18:43 INFO - mkdir: /builds/slave/test/build/tests 14:18: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')]} 14:18:43 INFO - https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 14:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 14:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 14:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 14:18:44 INFO - Downloaded 1277 bytes. 14:18:44 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 14:18:44 INFO - Using the following test package requirements: 14:18:44 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:18:44 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:18:44 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:18:44 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:18:44 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:18:44 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:18:44 INFO - u'jsshell-mac.zip'], 14:18:44 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:18:44 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:18:44 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:18:44 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:18:44 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:18:44 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:18:44 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:18:44 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:18:44 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:18:44 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:18:44 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:18:44 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:18:44 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:18: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')]} 14:18:44 INFO - https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:18:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:18:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:18:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/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 14:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/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 14:18:45 INFO - Downloaded 17855008 bytes. 14:18:45 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'] 14:18:45 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 14:18:48 INFO - Return code: 0 14:18:48 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 14:18: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')]} 14:18:48 INFO - https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:18:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:18:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:18:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/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 14:18:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/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 14:18:49 INFO - Downloaded 17855008 bytes. 14:18:49 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'] 14:18:49 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 14:18:53 INFO - Return code: 0 14:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:53 INFO - https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:18:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:18:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:18:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/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 14:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/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 14:18:54 INFO - Downloaded 10808263 bytes. 14:18:54 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'] 14:18:54 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 14:18:54 INFO - Return code: 0 14:18:54 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')]} 14:18:54 INFO - https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:18:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:18:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:18:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NN2pBl7pQoeKjH742bfk2A/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 14:18:57 INFO - Downloaded 110960174 bytes. 14:18:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:18:57 INFO - mkdir: /builds/slave/test/properties 14:18:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:57 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:57 INFO - Contents: 14:18:57 INFO - build_url:https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:18:58 INFO - Running post-action listener: _resource_record_post_action 14:18:58 INFO - Running post-action listener: set_extra_try_arguments 14:18:58 INFO - ##### 14:18:58 INFO - ##### Running populate-webroot step. 14:18:58 INFO - ##### 14:18:58 INFO - Running pre-action listener: _resource_record_pre_action 14:18:58 INFO - Running main action method: populate_webroot 14:18:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:58 INFO - '--tppagecycles', 14:18:58 INFO - '7'], 14:18:58 INFO - 'tests': ['tsvgm']}}, 14:18:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:18:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:18:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:58 INFO - 'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:58 INFO - 'tests': ['damp', 'tps']}, 14:18:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:58 INFO - 'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['damp', 'tps']}, 14:18:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:18:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:58 INFO - 'other': {'tests': ['a11yr', 14:18:58 INFO - 'ts_paint', 14:18:58 INFO - 'tpaint', 14:18:58 INFO - 'sessionrestore', 14:18:58 INFO - 'sessionrestore_no_auto_restore']}, 14:18:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['a11yr', 14:18:58 INFO - 'ts_paint', 14:18:58 INFO - 'tpaint', 14:18:58 INFO - 'sessionrestore', 14:18:58 INFO - 'sessionrestore_no_auto_restore']}, 14:18:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['a11yr', 14:18:58 INFO - 'ts_paint', 14:18:58 INFO - 'tpaint', 14:18:58 INFO - 'sessionrestore', 14:18:58 INFO - 'sessionrestore_no_auto_restore']}, 14:18:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['a11yr', 14:18:58 INFO - 'ts_paint', 14:18:58 INFO - 'tpaint', 14:18:58 INFO - 'sessionrestore', 14:18:58 INFO - 'sessionrestore_no_auto_restore']}, 14:18:58 INFO - 'other_l64': {'tests': ['a11yr', 14:18:58 INFO - 'ts_paint', 14:18:58 INFO - 'tpaint', 14:18:58 INFO - 'sessionrestore', 14:18:58 INFO - 'sessionrestore_no_auto_restore']}, 14:18:58 INFO - 'other_nol64': {'tests': ['a11yr', 14:18:58 INFO - 'ts_paint', 14:18:58 INFO - 'tpaint', 14:18:58 INFO - 'sessionrestore', 14:18:58 INFO - 'sessionrestore_no_auto_restore']}, 14:18:58 INFO - 'svgr': {'tests': ['tsvgx', 14:18:58 INFO - 'tsvgr_opacity', 14:18:58 INFO - 'tart', 14:18:58 INFO - 'tscrollx', 14:18:58 INFO - 'cart']}, 14:18:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['tsvgx', 14:18:58 INFO - 'tsvgr_opacity', 14:18:58 INFO - 'tart', 14:18:58 INFO - 'tscrollx', 14:18:58 INFO - 'cart']}, 14:18:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:58 INFO - 'tests': ['tp5o']}, 14:18:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:58 INFO - 'talos_options': ['--e10s'], 14:18:58 INFO - 'tests': ['tp5o']}, 14:18:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:58 INFO - 'talos_options': ['--xperf_path', 14:18:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:58 INFO - 'tests': ['tp5n']}, 14:18:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:58 INFO - 'talos_options': ['--e10s', 14:18:58 INFO - '--xperf_path', 14:18:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:58 INFO - 'tests': ['tp5n']}}, 14:18:58 INFO - 'talos.zip': {'path': '', 14:18:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:58 INFO - Running post-action listener: _resource_record_post_action 14:18:58 INFO - ##### 14:18:58 INFO - ##### Running create-virtualenv step. 14:18:58 INFO - ##### 14:18:58 INFO - Running pre-action listener: _resource_record_pre_action 14:18:58 INFO - Running main action method: create_virtualenv 14:18:58 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:58 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 14:18:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:58 INFO - Using real prefix '/tools/python27' 14:18:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:19:01 INFO - Installing pip.................done. 14:19:01 INFO - Return code: 0 14:19:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:19:01 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')]} 14:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:01 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')]} 14:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:01 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 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19:01 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 14:19:01 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 14:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:01 INFO - 'HOME': '/Users/cltbld', 14:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:01 INFO - 'LOGNAME': 'cltbld', 14:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:01 INFO - 'MOZ_NO_REMOTE': '1', 14:19:01 INFO - 'NO_EM_RESTART': '1', 14:19:01 INFO - 'PAGER': '/bin/cat', 14:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:01 INFO - 'PWD': '/builds/slave/test', 14:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:01 INFO - 'SHELL': '/bin/bash', 14:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:01 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:01 INFO - 'USER': 'cltbld', 14:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:01 INFO - 'XPC_FLAGS': '0x0', 14:19:01 INFO - 'XPC_SERVICE_NAME': '0', 14:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:02 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 14:19:02 INFO - Cleaning up... 14:19:02 INFO - Return code: 0 14:19:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:19:02 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')]} 14:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:02 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')]} 14:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:02 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 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19:02 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 14:19:02 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 14:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:02 INFO - 'HOME': '/Users/cltbld', 14:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:02 INFO - 'LOGNAME': 'cltbld', 14:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:02 INFO - 'MOZ_NO_REMOTE': '1', 14:19:02 INFO - 'NO_EM_RESTART': '1', 14:19:02 INFO - 'PAGER': '/bin/cat', 14:19:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:02 INFO - 'PWD': '/builds/slave/test', 14:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:02 INFO - 'SHELL': '/bin/bash', 14:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:02 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:02 INFO - 'USER': 'cltbld', 14:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:02 INFO - 'XPC_FLAGS': '0x0', 14:19:02 INFO - 'XPC_SERVICE_NAME': '0', 14:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:02 INFO - Downloading/unpacking psutil>=0.7.1 14:19:02 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 14:19:02 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 14:19:02 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 14:19:02 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 14:19:02 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 14:19:02 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 14:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:05 INFO - Installing collected packages: psutil 14:19:05 INFO - Running setup.py install for psutil 14:19:05 INFO - building 'psutil._psutil_osx' extension 14:19:05 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 14:19:05 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 14:19:05 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 14:19:05 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 14:19:05 INFO - building 'psutil._psutil_posix' extension 14:19:05 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 14:19:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:19:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:19:06 INFO - ^ 14:19:06 INFO - 1 warning generated. 14:19:06 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 14:19:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:06 INFO - Successfully installed psutil 14:19:06 INFO - Cleaning up... 14:19:06 INFO - Return code: 0 14:19:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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', '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 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:19: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 mozsystemmonitor==0.0.0 14:19:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:06 INFO - 'HOME': '/Users/cltbld', 14:19:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:06 INFO - 'LOGNAME': 'cltbld', 14:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:06 INFO - 'MOZ_NO_REMOTE': '1', 14:19:06 INFO - 'NO_EM_RESTART': '1', 14:19:06 INFO - 'PAGER': '/bin/cat', 14:19:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:06 INFO - 'PWD': '/builds/slave/test', 14:19:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:06 INFO - 'SHELL': '/bin/bash', 14:19:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:06 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:06 INFO - 'USER': 'cltbld', 14:19:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:06 INFO - 'XPC_FLAGS': '0x0', 14:19:06 INFO - 'XPC_SERVICE_NAME': '0', 14:19:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:19:08 INFO - Installing collected packages: mozsystemmonitor 14:19:08 INFO - Running setup.py install for mozsystemmonitor 14:19:09 INFO - Successfully installed mozsystemmonitor 14:19:09 INFO - Cleaning up... 14:19:09 INFO - Return code: 0 14:19:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:19:09 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')]} 14:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:09 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')]} 14:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:09 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 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19:09 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 14:19:09 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 14:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:09 INFO - 'HOME': '/Users/cltbld', 14:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:09 INFO - 'LOGNAME': 'cltbld', 14:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:09 INFO - 'MOZ_NO_REMOTE': '1', 14:19:09 INFO - 'NO_EM_RESTART': '1', 14:19:09 INFO - 'PAGER': '/bin/cat', 14:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:09 INFO - 'PWD': '/builds/slave/test', 14:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:09 INFO - 'SHELL': '/bin/bash', 14:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:09 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:09 INFO - 'USER': 'cltbld', 14:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:09 INFO - 'XPC_FLAGS': '0x0', 14:19:09 INFO - 'XPC_SERVICE_NAME': '0', 14:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:09 INFO - Downloading/unpacking blobuploader==1.2.4 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:11 INFO - Downloading blobuploader-1.2.4.tar.gz 14:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:19:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:19:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:12 INFO - Downloading docopt-0.6.1.tar.gz 14:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:19:13 INFO - Installing collected packages: blobuploader, requests, docopt 14:19:13 INFO - Running setup.py install for blobuploader 14:19:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:19:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:19:13 INFO - Running setup.py install for requests 14:19:13 INFO - Running setup.py install for docopt 14:19:13 INFO - Successfully installed blobuploader requests docopt 14:19:13 INFO - Cleaning up... 14:19:13 INFO - Return code: 0 14:19:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:13 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')]} 14:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:13 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')]} 14:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:13 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 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19:13 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 14:19:13 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 14:19:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:13 INFO - 'HOME': '/Users/cltbld', 14:19:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:13 INFO - 'LOGNAME': 'cltbld', 14:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:13 INFO - 'MOZ_NO_REMOTE': '1', 14:19:13 INFO - 'NO_EM_RESTART': '1', 14:19:13 INFO - 'PAGER': '/bin/cat', 14:19:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:13 INFO - 'PWD': '/builds/slave/test', 14:19:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:13 INFO - 'SHELL': '/bin/bash', 14:19:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:13 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:13 INFO - 'USER': 'cltbld', 14:19:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:13 INFO - 'XPC_FLAGS': '0x0', 14:19:13 INFO - 'XPC_SERVICE_NAME': '0', 14:19:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UTRJ4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-mVmhNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-YprsRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-BsDngO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Ywi6YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-wA2vmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Ur1kz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-qqJXy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:14 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bM828J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:15 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-KjKy2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:15 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-3_IqFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:15 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-6bC4UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:15 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-NYb1qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:15 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-3MqfeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:15 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-NXmVrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:15 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-PmSchs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:15 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-YTnpgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:19:15 INFO - Running setup.py install for manifestparser 14:19:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:19:16 INFO - Running setup.py install for mozcrash 14:19:16 INFO - Running setup.py install for mozdebug 14:19:16 INFO - Running setup.py install for mozdevice 14:19:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:19:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:19:16 INFO - Running setup.py install for mozfile 14:19:16 INFO - Running setup.py install for mozhttpd 14:19:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:19:16 INFO - Running setup.py install for mozinfo 14:19:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:19:16 INFO - Running setup.py install for mozInstall 14:19:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Running setup.py install for mozleak 14:19:17 INFO - Running setup.py install for mozlog 14:19:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Running setup.py install for moznetwork 14:19:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Running setup.py install for mozprocess 14:19:17 INFO - Running setup.py install for mozprofile 14:19:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:19:17 INFO - Running setup.py install for mozrunner 14:19:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:19:18 INFO - Running setup.py install for mozscreenshot 14:19:18 INFO - Running setup.py install for moztest 14:19:18 INFO - Running setup.py install for mozversion 14:19:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:19:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:19:18 INFO - Cleaning up... 14:19:18 INFO - Return code: 0 14:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:18 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')]} 14:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:18 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')]} 14:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:18 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 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19:18 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 14:19:18 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 14:19:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:18 INFO - 'HOME': '/Users/cltbld', 14:19:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:18 INFO - 'LOGNAME': 'cltbld', 14:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:18 INFO - 'MOZ_NO_REMOTE': '1', 14:19:18 INFO - 'NO_EM_RESTART': '1', 14:19:18 INFO - 'PAGER': '/bin/cat', 14:19:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:18 INFO - 'PWD': '/builds/slave/test', 14:19:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:18 INFO - 'SHELL': '/bin/bash', 14:19:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:18 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:18 INFO - 'USER': 'cltbld', 14:19:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:18 INFO - 'XPC_FLAGS': '0x0', 14:19:18 INFO - 'XPC_SERVICE_NAME': '0', 14:19:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-3bZrtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:18 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)) 14:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-5VNmQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:18 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)) 14:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-BXV_NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-PbZXwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EYHKh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-D_4sJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1lukm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-OkNwhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-3NPHvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Jg6WA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-DYb3Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:19 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)) 14:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EqOEXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:20 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)) 14:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:20 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-dXhTsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:20 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)) 14:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:20 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Tburc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:20 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)) 14:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:20 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-cGV30a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:20 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)) 14:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:20 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-H_DSty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:20 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)) 14:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:20 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-cwvdmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:20 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)) 14:19:20 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)) 14:19:20 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)) 14:19:20 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)) 14:19:20 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)) 14:19:20 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)) 14:19:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:19:20 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 14:19:20 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 14:19:20 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 14:19:20 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 14:19:20 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 14:19:20 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 14:19:22 INFO - Downloading blessings-1.6.tar.gz 14:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:19:22 INFO - Installing collected packages: blessings 14:19:22 INFO - Running setup.py install for blessings 14:19:23 INFO - Successfully installed blessings 14:19:23 INFO - Cleaning up... 14:19:23 INFO - Return code: 0 14:19:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:23 INFO - Reading from file tmpfile_stdout 14:19:23 INFO - Current package versions: 14:19:23 INFO - blessings == 1.6 14:19:23 INFO - blobuploader == 1.2.4 14:19:23 INFO - docopt == 0.6.1 14:19:23 INFO - manifestparser == 1.1 14:19:23 INFO - mozInstall == 1.12 14:19:23 INFO - mozcrash == 0.16 14:19:23 INFO - mozdebug == 0.1 14:19:23 INFO - mozdevice == 0.48 14:19:23 INFO - mozfile == 1.2 14:19:23 INFO - mozhttpd == 0.7 14:19:23 INFO - mozinfo == 0.9 14:19:23 INFO - mozleak == 0.1 14:19:23 INFO - mozlog == 3.1 14:19:23 INFO - moznetwork == 0.27 14:19:23 INFO - mozprocess == 0.22 14:19:23 INFO - mozprofile == 0.28 14:19:23 INFO - mozrunner == 6.11 14:19:23 INFO - mozscreenshot == 0.1 14:19:23 INFO - mozsystemmonitor == 0.0 14:19:23 INFO - moztest == 0.7 14:19:23 INFO - mozversion == 1.4 14:19:23 INFO - psutil == 3.1.1 14:19:23 INFO - requests == 1.2.3 14:19:23 INFO - wsgiref == 0.1.2 14:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:23 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 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19:23 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 14:19:23 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 14:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:23 INFO - 'HOME': '/Users/cltbld', 14:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:23 INFO - 'LOGNAME': 'cltbld', 14:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:23 INFO - 'MOZ_NO_REMOTE': '1', 14:19:23 INFO - 'NO_EM_RESTART': '1', 14:19:23 INFO - 'PAGER': '/bin/cat', 14:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:23 INFO - 'PWD': '/builds/slave/test', 14:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:23 INFO - 'SHELL': '/bin/bash', 14:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:23 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:23 INFO - 'USER': 'cltbld', 14:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:23 INFO - 'XPC_FLAGS': '0x0', 14:19:23 INFO - 'XPC_SERVICE_NAME': '0', 14:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 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)) 14:19:23 INFO - Cleaning up... 14:19:23 INFO - Return code: 0 14:19:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:23 INFO - 'HOME': '/Users/cltbld', 14:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:23 INFO - 'LOGNAME': 'cltbld', 14:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:23 INFO - 'MOZ_NO_REMOTE': '1', 14:19:23 INFO - 'NO_EM_RESTART': '1', 14:19:23 INFO - 'PAGER': '/bin/cat', 14:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:23 INFO - 'PWD': '/builds/slave/test', 14:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:23 INFO - 'SHELL': '/bin/bash', 14:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:23 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:23 INFO - 'USER': 'cltbld', 14:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:23 INFO - 'XPC_FLAGS': '0x0', 14:19:23 INFO - 'XPC_SERVICE_NAME': '0', 14:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:24 INFO - Downloading/unpacking jsonschema 14:19:24 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 14:19:24 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 14:19:24 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 14:19:24 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 14:19:24 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 14:19:24 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 14:19:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:19:26 INFO - Downloading/unpacking functools32 (from jsonschema) 14:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:26 INFO - Downloading functools32-3.2.3-2.tar.gz 14:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:19:26 INFO - warning: no files found matching '*.txt' 14:19:26 INFO - no previously-included directories found matching 'build' 14:19:26 INFO - no previously-included directories found matching 'dist' 14:19:26 INFO - no previously-included directories found matching '.git*' 14:19:26 INFO - Installing collected packages: jsonschema, functools32 14:19:26 INFO - Running setup.py install for functools32 14:19:27 INFO - warning: no files found matching '*.txt' 14:19:27 INFO - no previously-included directories found matching 'build' 14:19:27 INFO - no previously-included directories found matching 'dist' 14:19:27 INFO - no previously-included directories found matching '.git*' 14:19:27 INFO - Successfully installed jsonschema functools32 14:19:27 INFO - Cleaning up... 14:19:27 INFO - Return code: 0 14:19:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:19:27 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')]} 14:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:27 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')]} 14:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:27 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 0x10eb77a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0bc6d490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, '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.bmWeyj1Duc/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.21YarR7erH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:19:27 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 14:19:27 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 14:19:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:19:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:27 INFO - 'HOME': '/Users/cltbld', 14:19:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:27 INFO - 'LOGNAME': 'cltbld', 14:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:27 INFO - 'MOZ_NO_REMOTE': '1', 14:19:27 INFO - 'NO_EM_RESTART': '1', 14:19:27 INFO - 'PAGER': '/bin/cat', 14:19:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:27 INFO - 'PWD': '/builds/slave/test', 14:19:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:27 INFO - 'SHELL': '/bin/bash', 14:19:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:19:27 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:19:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:27 INFO - 'USER': 'cltbld', 14:19:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:27 INFO - 'XPC_FLAGS': '0x0', 14:19:27 INFO - 'XPC_SERVICE_NAME': '0', 14:19:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:27 INFO - Downloading/unpacking flake8 14:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:19:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:19:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:31 INFO - no previously-included directories found matching 'docs/_build' 14:19:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:19:31 INFO - Running setup.py install for pep8 14:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:31 INFO - no previously-included directories found matching 'docs/_build' 14:19:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:19:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:19:31 INFO - Cleaning up... 14:19:31 INFO - Return code: 0 14:19:31 INFO - Running post-action listener: _resource_record_post_action 14:19:31 INFO - Running post-action listener: _start_resource_monitoring 14:19:31 INFO - Starting resource monitoring. 14:19:31 INFO - ##### 14:19:31 INFO - ##### Running install step. 14:19:31 INFO - ##### 14:19:31 INFO - Running pre-action listener: _resource_record_pre_action 14:19:31 INFO - Running main action method: install 14:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:31 INFO - Reading from file tmpfile_stdout 14:19:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:19:31 INFO - Reading from file tmpfile_stdout 14:19:31 INFO - Output received: 14:19:31 INFO - Usage: mozinstall [options] installer 14:19:31 INFO - Options: 14:19:31 INFO - -h, --help show this help message and exit 14:19:31 INFO - -d DEST, --destination=DEST 14:19:31 INFO - Directory to install application into. [default: 14:19:31 INFO - "/builds/slave/test"] 14:19:31 INFO - --app=APP Application being installed. [default: firefox] 14:19:31 INFO - mkdir: /builds/slave/test/build/application 14:19:31 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'] 14:19:31 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 14:20:05 INFO - Reading from file tmpfile_stdout 14:20:05 INFO - Output received: 14:20:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:20:05 INFO - Running post-action listener: _resource_record_post_action 14:20:05 INFO - ##### 14:20:05 INFO - ##### Running run-tests step. 14:20:05 INFO - ##### 14:20:05 INFO - Running pre-action listener: _resource_record_pre_action 14:20:05 INFO - Running main action method: run_tests 14:20:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:20:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:20:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:20:05 INFO - 2016-03-02 14:20:05.189 screenresolution[1936:12565] starting screenresolution argv=screenresolution get 14:20:05 INFO - 2016-03-02 14:20:05.192 screenresolution[1936:12565] Display 0: 1600x1200x32@60 14:20:05 INFO - 2016-03-02 14:20:05.197 screenresolution[1937:12567] starting screenresolution argv=screenresolution list 14:20:05 INFO - Available Modes on Display 0 14:20:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:20:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:20:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:20:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:20:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:20:05 INFO - Intel Iris: 14:20:05 INFO - Chipset Model: Intel Iris 14:20:05 INFO - Type: GPU 14:20:05 INFO - Bus: Built-In 14:20:05 INFO - VRAM (Dynamic, Max): 1536 MB 14:20:05 INFO - Vendor: Intel (0x8086) 14:20:05 INFO - Device ID: 0x0a2e 14:20:05 INFO - Revision ID: 0x0009 14:20:05 INFO - Displays: 14:20:05 INFO - Display: 14:20:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:20:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:20:05 INFO - Display Serial Number: 1600x1200 60 14:20:05 INFO - Main Display: Yes 14:20:05 INFO - Mirror: Off 14:20:05 INFO - Online: Yes 14:20:05 INFO - Rotation: Supported 14:20:05 INFO - Return code: 0 14:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:20:05 INFO - Python 2.7.3 14:20:05 INFO - Return code: 0 14:20:05 INFO - grabbing minidump binary from tooltool 14:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:05 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 0x10ea1bd30>, '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 0x10e83fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea12b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:20:05 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 14:20:05 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 14:20:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:20:05 INFO - Return code: 0 14:20:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:20:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:20:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:20:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:20:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:20:06 INFO - Return code: 0 14:20:06 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/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 14:20:06 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/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 14:20:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmWeyj1Duc/Render', 14:20:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:06 INFO - 'HOME': '/Users/cltbld', 14:20:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:06 INFO - 'LOGNAME': 'cltbld', 14:20:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:20:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:06 INFO - 'MOZ_NO_REMOTE': '1', 14:20:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:20:06 INFO - 'NO_EM_RESTART': '1', 14:20:06 INFO - 'PAGER': '/bin/cat', 14:20:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:06 INFO - 'PWD': '/builds/slave/test', 14:20:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:20:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:06 INFO - 'SHELL': '/bin/bash', 14:20:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21YarR7erH/Listeners', 14:20:06 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:20:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:06 INFO - 'USER': 'cltbld', 14:20:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:06 INFO - 'XPC_FLAGS': '0x0', 14:20:06 INFO - 'XPC_SERVICE_NAME': '0', 14:20:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:06 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/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 14:20:06 INFO - mozversion application_buildid: 20160302124322 14:20:06 INFO - mozversion application_changeset: 5ea9a54a24d60dc63df47c4f7f5231b66d8835c6 14:20:06 INFO - mozversion application_display_name: Nightly 14:20:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:20:06 INFO - mozversion application_name: Firefox 14:20:06 INFO - mozversion application_remotingname: firefox 14:20:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:20:06 INFO - mozversion application_vendor: Mozilla 14:20:06 INFO - mozversion application_version: 47.0a1 14:20:06 INFO - mozversion platform_buildid: 20160302124322 14:20:06 INFO - mozversion platform_changeset: 5ea9a54a24d60dc63df47c4f7f5231b66d8835c6 14:20:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:20:06 INFO - mozversion platform_version: 47.0a1 14:20:06 INFO - using testdate: 1456957206 14:20:06 INFO - actual date: 1456957206 14:20:06 INFO - starting webserver on 'localhost:49599' 14:20:06 INFO - SUITE-START | Running 2 tests 14:20:06 INFO - TEST-START | dromaeo_css 14:20:06 INFO - operating with platform_type : mac_ 14:20:06 INFO - Initialising browser for dromaeo_css test... 14:20:07 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmph2FsIK/profile http://localhost:49599/getInfo.html) 14:20:09 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 14:20:09 INFO - PROCESS | 1955 | colorDepth:24 14:20:09 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 14:20:09 INFO - PROCESS | 1955 | __metrics 14:20:09 ERROR - PROCESS | 1955 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:20:10 INFO - TEST-INFO | 1955: exit 0 14:20:10 INFO - Browser initialized. 14:20:10 INFO - Running cycle 1/1 for dromaeo_css test... 14:20:10 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmph2FsIK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:22 INFO - PROCESS | 1959 | RSS: Main: 254013440 14:20:22 INFO - PROCESS | 1959 | 14:21:11 INFO - PROCESS | 1959 | 1456957271804 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] 14:23:22 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49599/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49599/tests/dromaeo/cssquery-ext.html) 14:23:23 INFO - PROCESS | 1959 | RSS: Main: 269275136 14:23:23 INFO - PROCESS | 1959 | 14:26:25 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49599/tests/dromaeo/cssquery-ext.html (next: http://localhost:49599/tests/dromaeo/cssquery-jquery.html) 14:26:26 INFO - PROCESS | 1959 | RSS: Main: 280670208 14:26:26 INFO - PROCESS | 1959 | 14:29:28 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49599/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49599/tests/dromaeo/cssquery-mootools.html) 14:29:28 INFO - PROCESS | 1959 | RSS: Main: 282648576 14:29:28 INFO - PROCESS | 1959 | 14:32:30 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49599/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49599/tests/dromaeo/cssquery-prototype.html) 14:32:31 INFO - PROCESS | 1959 | RSS: Main: 284393472 14:32:31 INFO - PROCESS | 1959 | 14:35:33 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49599/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49599/tests/dromaeo/cssquery-yui.html) 14:35:34 INFO - PROCESS | 1959 | RSS: Main: 288055296 14:35:34 INFO - PROCESS | 1959 | 14:38:36 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49599/tests/dromaeo/cssquery-yui.html (next: http://localhost:49599/tests/dromaeo/cssquery-dojo.html) 14:38:37 INFO - PROCESS | 1959 | RSS: Main: 289026048 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - PROCESS | 1959 | __start_tp_report 14:38:37 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 14:38:37 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 14:38:37 INFO - PROCESS | 1959 | |i|pagename|runs| 14:38:37 INFO - PROCESS | 1959 | |0;dojo.html;3475.1312171957006;3478.0956951192684;3501.0372147659373;3544.787312761234;3545.9645403545956;5451.509364157225;5676.063449530833;5691.288588926384;5692.203091567184;5718.685472299022;5523.944760552393;5591.664500129995;5696.601237913348;5725.541956643469;5746.626469279494;4967.882226499027;5122.974385128069;5143.151380022292;5203.011427828719;5204.375474943012;4222.282212023963;4696.624270058387;5215.113430716769;5277.70972596507;5280.656757310781;5047.49525047496;5057.5701065409485;5126.53861152498;5163.096458119851;5186.740662966837;5179.637425380225;5181.093308670967;5191.2472691459525;5206.7917283308625;5242;4288.892777680552;4469.932951005738;4757.5718185363485;5097.974510127426;5176.378834539842;5468.589855760833;5552.139418390116;5603.971980140114;5626.127950167731;5651.8304450866535;6188.628682279078;6208.906866397007;6220.098085777582;6245.156903817971;6245.313015568284;6105.175801266817;6183.876322473526;6199.318075011745;6202.844928876769;6206.6586337751405;5760.654360738369;5835.708214589254;5853.356130825606;5858.326292476378;5871.735771890275;6212;6214.8135555933395;6227.19046523949;6257.374262573706;6262.592931459531;5897.439743224472;6101.115338275925;6141.140240366352;6179.351168127282;6187.16473276111;5142.382914050263;6118.755249789959;6136.1821086261625;6157.983932651063;6182.474489668339;6138.294096178907;6145.262568491809;6157;6164.4143806338325;6168.19813424252;6090.604110732788;6191.19514463117;6203.503719702413;6208.1308616793685;6214.658193799294;4817.181079216542;4915.557599816034;4918.778654960535;4929.162042452792;4964.478729733398;4355.107203023373;4375.649948004216;4379.321205213197;4419.359192917009;4457.4205353304515;5577.9163312550345;5590.496855283044;5663.745131469093;5690.516306113944;5691.089425691869;6123.679189354777;6168.074788781629;6187.504999600022;6207.96896015517;6232.127502149703;5672.347680016768;5685.658860468385;5692.402297758676;5702.771889124471;5754.021816291241;5203.2195170723935;5321.86695332612;5349.679019258857;5367.865803354947;5387.838364849061;6234.438900498886;6251.3123556408755;6257.5932564383165;6259.280182779039;6273.811785646438;6188.133661287334;6209;6223.315435302204;6228.159198508325;6232.626042437469;6131.896637733107;6146.446819786241;6170.352113028068;6178.41305076017;6229.4393504584805;6112.022076467744;6128.908066379097;6160.661163636043;6163.722632481459;6186.659733714689;6154.476869466145;6184.752609895554;6204.5967012144065;6220.533459990428;6225.595336303126;5795.782885593904;6019.969900150471;6083.087536869505;6097;6132.936844521141;6063.029915213545;6063.818085457443;6067.574120081689;6068.332483426731;6070.666113363807;4846.860987667966;5550.028744969695;5868.295804503487;5925.614835035709;5938.287405511366;5038.496150384932;6020.8795824084145;6101.671357587221;6127.938720612737;6133.969330153321;5964.403559644001;5975.462208401264;5976.193213916065;5987.2815262168815;6018.638881667114 14:38:37 INFO - PROCESS | 1959 | |1;ext.html;528.281537109531;561.6237121128845;562.8198976327574;595.520605912241;653.2552889705736;29303.706962930366;37138.44292335617;37166.44250336247;37223.441648375265;37230.88307350784;32894.34211315772;35878.2824343513;37837.86486405412;38508.42237366442;39329;9345.392549484295;9494.240460763122;9566.330356875022;9573.42559446432;9582.99378565251;9379.718608441757;9535.094166054214;9613.567389467456;9627.085426884434;9651.565679544403;9578.808423831519;9651.420914745138;9658.275629327793;9666.903330966707;9691.982341854075;9510.33427660064;9547.997460266675;9587.376820506715;9632.759181020461;9640.80718385632;9442.716718498456;9561.422365309716;9573.569189386495;9589.42463452195;9597.560365945094;37156;37325.25349492995;37528.43707344392;37532.81233593842;37599.24801503982;3110.28463453407;3143.3398986212924;3289.3092450585405;3337.933241335184;3393.100828280508;27810.16569502918;27839;28255.858720706266;28383.57424638632;28477.57283640747;2666.373402250489;2734;2746.945061098767;2768.3909539901188;2778.2082106599523;414168;417893;418318;419073.80926190654;419664;48431;50704.492955069974;62266;62316.68841655763;62356;66385;70004;70476.64761676159;70514;70876;15967.121808300655;16028.599285017735;16082.919585402233;16242;16287.267072981744;10010.799784004279;10385.324953877975;12048.578299759467;12251;12337.814932776015;20448.284310049075;20781.89609051945;20783;20798.37604871856;21623;7891.210878912178;8739.388242823068;8785.341099417441;9062.50156241413;9104.408213466104;913.3378300731916;942.9434233945985;957.1003256938455;960.2366118935463;1007.6976906927893;27913.720862791113;29035.854820725763;29196.124116276547;29445.411091778045;29643.85178074096;986.4328011393477;1039.7140786283833;1078.7680648660576;1082.9187810914214;1145.2326940949417;14023.08849924772;14224.217668028357;14225.715485690229;14372.784408233885;14380.065295755743;492449;494360;497296;500637;501279;45423.09153816905;55144.172837407474;57150;57255.14117288244;57353.27940161718;1354.9187048777105;1361.598328493097;1361.6731984323692;1381.696026874106;1391.0123812093325;25113;25530.617040744775;26735.732642673323;27472.313192170357;27987.44025119527;46696.766516167205;46936.7653161732;47080.05839883115;47508;47577.04845903132;440908.59091408673;443056;445744;448590;450054;32659.673403265664;32720.509192361656;32734;33129.50305745367;33371.499427509094;43635.345469817345;43687.78156109199;43709.344359833995;44018.33972490479;44174.55825441833;30225.201550925907;32644.34711305808;35975.460368093976;37172.256554869295;37384.252314954094;35998;36243.45634815427;36528.26943461169;36579;36658.63341366552;28699.282517936383;36707.08232294214;36850.8157459211;36945.63054369422;37853.62146378611;28011;29850.552241715955;31040.0687979361;31215.84392078025;31909.20226994344;23671.52656946817;23869.761302386753;23963;24255.75744242535;24563.385915351544 14:38:37 INFO - PROCESS | 1959 | |2;jquery.html;351.89267273481596;358.1404628890662;359.98380072896725;362.60657186952153;369.61006138523845;19174.808251917475;19469.415917522463;20618.9690515474;20643.69034464484;20646.793532064676;11415.42922853856;19417.514562135955;19715.704264436044;19876.701849472232;19903.203871845144;5217.399999000107;5372.167314066306;5403.2165336026255;5426.864328391802;5428.538574221196;3989;5339.439358867321;5802.564807639423;6054.243219597551;6059.545534084939;5928.258967629046;6006.7897623583185;6052.243469566304;6054.273487181545;6065.181200537937;5780.739866706008;5929.517620594851;5984.102384642295;5987;5990.640561566276;5633.971830140864;5673.914891276634;5679.943200567983;5687.772489100473;5695.7152142392715;11243.662690119229;11282.605108821152;13038.86961130386;13646;13706.588802335946;1676.8071671757782;1977.9703304450445;1986.1161783006569;2216.5788500184913;2218.057325636598;7422.6288685565505;9410.153086222273;9651.276154288456;9885;10232.02795734404;1414.6109819799535;1588.8411158884135;1665.4337525241476;1674.045793897479;1706.6586682663517;101260;109982;110934.89065109326;111248;113254;10789.460526973777;11097.55609775616;11177.105831533458;11253.943730281297;11284.32294062359;13451.730965380833;13527.188368697909;13546.729065418833;13563.321833908265;13568.660783480294;8330.62512186953;8332.291755200877;8528.616212270463;8542.829143417097;8559.186877246651;8550.78623034429;8567.143285671384;8588.847583643123;8658.740237792876;8751.649934002697;4467.329900514948;4503.211937910853;4503.256962601135;4531.77341132942;4641.698289611232;1793;1878.1548303263587;2936.6182396288345;3269.4115059289556;3544.2379888324135;659.6606610473348;834.2908527751484;898.81574277273;935.2751617496359;1002.9539738932642;18212.45362639123;18274.26902923895;19270;19877.105530251174;19943.301984430476;915.5102020419043;925.2043242811177;934.6121359635675;959.3907868503411;992.7071513903416;10316.226283028804;10486.318389304672;10542.947285263677;10569.365838049742;10608.20438467118;596647;601073;606611.7024733898;607551;620452;100170.49914750525;118903;120723;122463.38768306101;125142;997.2620261006803;1017.8803316351954;1026.820306446369;1031.9174466042698;1034.4517405774952;14532.491362802251;17602.207900644757;17671.028093454985;17856.821431785516;18090.819091808913;39406.60593394144;53673;54047;54051.18923216076;55210;76999;77561;77652.2234777645;77753.61123194348;79423.60288198522;7970.163132871197;7995.720149794729;8147.592620369076;8161.836763264821;8308.169183081643;11633.709157271136;12147.939260303641;12674.936625317183;12991.35043247815;13068.673283167996;9625.71122866315;10676.733081673021;11059;11180.385078820744;11381.43092845371;9126.954365228132;10818.1886358525;10981.121510279318;11193.944030279796;11263.66209013731;9026.548672566214;11330.773384532427;11380.54477820878;11519.366434846164;11531.94627127429;7983.281504664608;8052.194780521901;8103.432759706764;8353.081161072156;8359.623816928131;10849;11139.554417823196;11261.66215013551;11292.153088518558;11414.771704565695 14:38:37 INFO - PROCESS | 1959 | |3;mootools.html;1350.7906274527445;1361.2921280933915;1538.092525410008;1642.819289878114;1792.2024699008946;7044.577325360476;7775.416843736728;7790.727324543628;8699.652013919436;8715.477071375713;6834.96582517088;8469.618867150977;8547.957260213705;8571.528565928871;8588.95705521473;2433.3916520869784;2447.9755202447927;2448.7061552613714;2448.8897999590063;2464.2484042367073;2238.563480121377;2240.8571628469435;2441.218809980807;2456.9017239310406;2463.3102731235194;2421.079989603948;2425.8059355251626;2445.1075357494565;2449.0448724997264;2459.4220358215807;2416.66166736657;2428.672129262545;2428.7571242875747;2439.841410308324;2461.692288463942;2174.68431598882;2302.458922153293;2344.542814151241;2397.6043952747777;2402.531506356261;8628.956855215747;8650.178233067849;8654.913450865537;8679.739607811776;8691.652333906635;5213.4004589472315;5342.626016178869;5356.625036247464;5358.410574836765;5361.08861493547;3524.4537096750046;3576.535050443452;3642.9453558196647;3670.4127339625534;3675.8345874435713;1048.26621365044;1065.2010991756183;1068.4444089073638;1071.3839542263152;1072.6406653770996;11512.194146409754;11641.41792910351;11644.475998580085;11666.708332291675;11673.357965311905;4733.532604892425;4738.5261473853025;4828.66199366041;4846.5153484651255;4870.829520966749;9724.076212759777;9754.634351190838;9831.901680983241;9848.655297064568;9886.110250077527;5332.866678333073;5354.9464505354445;5374.811881584125;5386.272853164773;5389.649672771257;4333.414988976511;4714.858554243378;4839.661223714306;4889.291052797395;4906.386701662293;3803.353429916921;3867.57456679765;3868.9226215476097;3903.277893589695;3913.099987003005;1273.064297741178;1276.6361586947676;1277.1698396042646;1283.4994352202648;1287.620152055146;1016.903394177552;1024.5799222318813;1024.6669832304383;1142.7428828513684;1339.1161833190242;7846.882296765553;7862.52824830512;7898.881516777253;7967.721129760431;7983.8403231935035;476.19760703215195;479.8776312040477;481.24684868181885;483.45128279403133;483.6300230323805;5928.318243401977;5941;6111.724972376253;6162.876742465126;6184.938150618436;8604.956975215084;10236.641717539851;10429.322094064013;10471.633492827714;10623.043926046694;10373.325733827278;10403.63587274457;10410.947945260225;10459.738506537245;10488.842667359995;7950.403719721044;8255.793605159919;8294.129116442688;8299.585020748938;8346.4157508975;7716.498427602188;7720.498167619086;7727.9953606033105;7746.341560967381;7756.224377562198;9086.909130908607;9097.727068187965;9112.225460835904;9301.813963720822;9357.01751316102;9471.052894710474;9477.289203309641;9478.336516443782;9563.808723825345;9828.31201815866;6054.8183554493435;6668.266490686117;7295.489315747846;7380.96309518449;7486.7005319786595;6369.363063693593;7993;8016.6392512335915;8021.959890200512;8036.799080023046;6987;7145.035420218204;7172.282771722786;7232.674529646073;7318.231585683639;6119.694015299128;6975.581465112109;7022.367986881;7081.68132434052;7116.644167791694;7526.811829704301;7529;7561.281678240558;7572.507786993828;7619.619019049136;6908.067410899464;6924.169099708067;6931.202911665021;6970.825729356807;6990.965045174741;6956.200036995608;7023.719051237893;7027.61348125858;7038.40173585251;7059.964700176466 14:38:37 INFO - PROCESS | 1959 | |4;prototype.html;320.7289840085128;323.6294442862922;325.80614534352054;329.95545601343827;331.25963471640887;6793.286704895982;6883.070785443963;6901.654917254143;6908.343707347806;6947;6659.833504162386;6707.664616769166;6716.395524402803;6727.461803055756;6796.014577886203;4765.976170119145;4878.878028049292;4968.726720030415;5006.5744411725045;5043.016611760708;4984.451710311862;4990.850274491771;5014.398272207322;5026.2711906773675;5027.899442011158;4505.504394516601;4737.147313483571;4931.408231012284;4956.925646115311;4958.528939750736;4937.580305674022;4943.629227807911;4944.826931057396;4949.034938187055;4980.501949805027;4254.404383386297;4272.6795490338345;4276.828926842923;4293.914121717579;4300.935485967713;6086.9391306087255;6242.344553821828;6544.181977252843;6549.672516374162;6573.408393244631;5721.313442386899;5756.762296106315;5758.798442054508;5767.394423585547;5787.450192231731;7279.708811647528;7292.74475393364;7299.160596531361;7300.7444739434395;7304.780856574312;3906.374980003214;4635.95364046362;4642.930356044662;4643.210654188796;4643.907121857544;7325.597092159983;7659.119201291867;7676.9616151919445;7685.42359323053;7717.807054823675;4054.9391759123637;4330.0040990571715;4507.166174257773;4584.908301833944;4670.416197975253;3923.9607603923596;4726.031163611451;4751.049790041936;4776.95223047772;4782.258749893772;5690.402507736628;5706.771729130871;5707.34365547959;5721.056025755787;5726.255586773693;7226.566406015656;7240.2035776064595;7309.305615966475;7337.266273372727;7340.119185697644;1640.753886916972;1669.2321532095373;1675.9581010474592;1676.983230167707;1682.6045879218375;1020.0717347213999;1066.3548553125402;1067.2422579968309;1067.64767626683;1072.1637123044038;6765.864682706417;6802.727890884408;6823.965880170567;6824.965875170592;6831.316868313129;7643.044619422572;7649.235076492418;7668.702457943026;7669.7315593953945;7674.002379690604;5611.298587676541;6517.95712685968;6811.2167100784045;6815.148106486689;6829.112215411965;3938.6061393860386;4018.8794336169963;4049.8582549610624;4061.7969101544804;4073.4093556434746;6976.372126508639;7398.3341499265325;7960.681572737026;8027.237412445808;8031.55826429552;6860.3825655690225;7903.9209607903185;7958.960205199052;7985.121636619967;7999.640016199285;8009.399295052895;8020.799480013046;8025.799355016171;8041.9947506561675;8052.798680033046;7368.815779605553;7716.382689384724;7733.110692270461;7733.419993500397;7769.844603108019;7562.054743157106;7601.695932162652;7609.771706848804;7622.237776222333;7638.847223055619;6491.772787952399;7988.6405111768945;7999.400044996532;8036.357091432555;8055;4706.552877476634;4762.190427627381;4762.3570817939135;4764.2615394613895;4780.856574302777;7349.853002939804;7539.811504712426;7647.464677472523;7666.923330766844;7708.306252437307;5980.790672326448;7345.5959922202655;7377.897299269683;7404.888926665996;7410.184879663125;7401.259874012556;7402.037735094618;7418.925810741824;7434.7769566913075;7437.665305061177;6983.580985140908;7228.530145540523;7234.348908598251;7245.673944672397;7246;6063.454289114001;7384.818429051541;7402.962985185255;7429.8142546436775;7434.182239953492;7097.716091356495;7241.927580724336;7244.927550724636;7274.127104747464;7281.308275713799 14:38:37 INFO - PROCESS | 1959 | |5;yui.html;672.3914857054366;703.2896774257998;720.0639169080196;729.1541811498663;737.9372753315968;14592.4892628758;14882.479113231038;14902.850971490281;14947.701045979074;14975.87680923931;13616.114952528078;13642.590722278323;15522.689546209069;15812.525624231292;15923;721.5923003503004;869.326272139091;874.5059041641468;880.4321212817729;881.4446898453997;868.2099289646424;891.6388862510661;897.1521911793358;899.0470101692194;902.6524787956652;918.912703293186;929.066288380177;932.2868005975434;939.5865819039635;941.1200527506769;900.9234215091725;918.3525614441869;929.809389075238;932.9486878221695;933.4539294512718;660.6234446365573;677.0724107972061;690.6305126757161;693.5769180799708;696.1680791454214;15163.848361516353;15176.696466070616;15184.392624295126;15255.694886102216;15291.923540382339;12326.19879707825;12393.194442361219;12416.565420210249;12564.937175314066;12597.748045039049;8456.40805143634;9883.456409897453;9952.651657191964;10041.598336066621;10341.121004714609;3478.826058697055;3519.5072689823446;3539.292141571696;3544.61009288978;3554.0581745837376;68933;76534.85197722039;81828.59085704593;82472.76290855581;83173;9366.110219529133;9367.250619950388;9402.858957115648;9472.431654100637;9610.711678649652;21759.45601359947;21820.672689909665;22090.88954555249;22132.88933555322;22134.003969821395;6498.610083394917;7379.372753316028;7450.18048014718;7528.058992625922;7591.8861217080685;3979.1047014421524;4018.7186896916937;4062.695297852673;4067.9796601016806;4079.3880917861966;3522.806245656462;3525.9294814104087;3555.822208889545;3569.214772749991;3572.3212589607892;606.8513214262534;614.3181069013392;659.1365311442026;661.2428769059496;662.5627086123136;477.43900916423064;573.2862586080356;577.7804434315018;582.7406803972276;623.4389049855166;8074.273315401642;8082.838343233102;8156.265936065783;8182.590870456454;8304.125101105357;569.5130663282916;579.547952596975;599.409581562161;614.1862032806549;615.6983078291695;3615.783053016775;3643.2531331077066;3771.8868433947027;3822.5412950446125;3850.2876967761053;79443.80834287491;79709;81350.18649813427;81441.59279203566;81536.59231703804;72814.90777638339;73505.63247183729;73742.63128684323;73913.52172956511;74393;64005;64206.35793642097;65114.674426627564;65535;66028.66985665137;7572.659230334758;7575.318221360104;7616.543007419573;7668.6165691716305;7835.451518393657;45193.32210016787;46321;46693.53306466892;46699.76650116728;47203;45678.77160614176;58089;59263.40736592579;62127.06809397953;63070.68464657831;9767.60929562838;9860.852087218555;10969.616063438061;11297.830532541853;11366.318020918441;11780.175387722777;11938.22401543897;12055.819162712742;12194.451249693962;12545.680255659632;11070.5571777128;11076.169287303323;11411;11443.970042696197;11576.305421674726;11085.556577736801;11253.66239012831;11360.204785664924;11586.536538538365;11890.643280701594;10640.574377024832;10926.56293748273;11078.612248571262;11194.944025279821;11374.260673056226;9180.540972951192;9456.14894659484;9590.136887680143;9590.808183836423;9765.121139097515;7770.805729856799;9203;9272.768180795534;9383.483908384831;9443.905560944302 14:38:37 INFO - PROCESS | 1959 | __end_tp_report 14:38:37 INFO - PROCESS | 1959 | __start_cc_report 14:38:37 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,336 14:38:37 INFO - PROCESS | 1959 | __end_cc_report 14:38:37 INFO - PROCESS | 1959 | __startTimestamp1456958317067__endTimestamp 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - PROCESS | 1959 | ------- Summary: start ------- 14:38:37 INFO - PROCESS | 1959 | Number of tests: 6 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - PROCESS | 1959 | [#0] dojo.html Cycles:165 Average:5670.60 Median:5925.61 stddev:649.63 (11.0%) stddev-sans-first:628.37 14:38:37 INFO - PROCESS | 1959 | Values: 3475.1 3478.1 3501.0 3544.8 3546.0 5451.5 5676.1 5691.3 5692.2 5718.7 5523.9 5591.7 5696.6 5725.5 5746.6 4967.9 5123.0 5143.2 5203.0 5204.4 4222.3 4696.6 5215.1 5277.7 5280.7 5047.5 5057.6 5126.5 5163.1 5186.7 5179.6 5181.1 5191.2 5206.8 5242.0 4288.9 4469.9 4757.6 5098.0 5176.4 5468.6 5552.1 5604.0 5626.1 5651.8 6188.6 6208.9 6220.1 6245.2 6245.3 6105.2 6183.9 6199.3 6202.8 6206.7 5760.7 5835.7 5853.4 5858.3 5871.7 6212.0 6214.8 6227.2 6257.4 6262.6 5897.4 6101.1 6141.1 6179.4 6187.2 5142.4 6118.8 6136.2 6158.0 6182.5 6138.3 6145.3 6157.0 6164.4 6168.2 6090.6 6191.2 6203.5 6208.1 6214.7 4817.2 4915.6 4918.8 4929.2 4964.5 4355.1 4375.6 4379.3 4419.4 4457.4 5577.9 5590.5 5663.7 5690.5 5691.1 6123.7 6168.1 6187.5 6208.0 6232.1 5672.3 5685.7 5692.4 5702.8 5754.0 5203.2 5321.9 5349.7 5367.9 5387.8 6234.4 6251.3 6257.6 6259.3 6273.8 6188.1 6209.0 6223.3 6228.2 6232.6 6131.9 6146.4 6170.4 6178.4 6229.4 6112.0 6128.9 6160.7 6163.7 6186.7 6154.5 6184.8 6204.6 6220.5 6225.6 5795.8 6020.0 6083.1 6097.0 6132.9 6063.0 6063.8 6067.6 6068.3 6070.7 4846.9 5550.0 5868.3 5925.6 5938.3 5038.5 6020.9 6101.7 6127.9 6134.0 5964.4 5975.5 5976.2 5987.3 6018.6 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - PROCESS | 1959 | [#1] ext.html Cycles:180 Average:59717.30 Median:37278.07 stddev:120719.91 (323.8%) stddev-sans-first:120976.76 14:38:37 INFO - PROCESS | 1959 | Values: 528.3 561.6 562.8 595.5 653.3 29303.7 37138.4 37166.4 37223.4 37230.9 32894.3 35878.3 37837.9 38508.4 39329.0 9345.4 9494.2 9566.3 9573.4 9583.0 9379.7 9535.1 9613.6 9627.1 9651.6 9578.8 9651.4 9658.3 9666.9 9692.0 9510.3 9548.0 9587.4 9632.8 9640.8 9442.7 9561.4 9573.6 9589.4 9597.6 37156.0 37325.3 37528.4 37532.8 37599.2 3110.3 3143.3 3289.3 3337.9 3393.1 27810.2 27839.0 28255.9 28383.6 28477.6 2666.4 2734.0 2746.9 2768.4 2778.2 414168.0 417893.0 418318.0 419073.8 419664.0 48431.0 50704.5 62266.0 62316.7 62356.0 66385.0 70004.0 70476.6 70514.0 70876.0 15967.1 16028.6 16082.9 16242.0 16287.3 10010.8 10385.3 12048.6 12251.0 12337.8 20448.3 20781.9 20783.0 20798.4 21623.0 7891.2 8739.4 8785.3 9062.5 9104.4 913.3 942.9 957.1 960.2 1007.7 27913.7 29035.9 29196.1 29445.4 29643.9 986.4 1039.7 1078.8 1082.9 1145.2 14023.1 14224.2 14225.7 14372.8 14380.1 492449.0 494360.0 497296.0 500637.0 501279.0 45423.1 55144.2 57150.0 57255.1 57353.3 1354.9 1361.6 1361.7 1381.7 1391.0 25113.0 25530.6 26735.7 27472.3 27987.4 46696.8 46936.8 47080.1 47508.0 47577.0 440908.6 443056.0 445744.0 448590.0 450054.0 32659.7 32720.5 32734.0 33129.5 33371.5 43635.3 43687.8 43709.3 44018.3 44174.6 30225.2 32644.3 35975.5 37172.3 37384.3 35998.0 36243.5 36528.3 36579.0 36658.6 28699.3 36707.1 36850.8 36945.6 37853.6 28011.0 29850.6 31040.1 31215.8 31909.2 23671.5 23869.8 23963.0 24255.8 24563.4 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - PROCESS | 1959 | [#2] jquery.html Cycles:180 Average:34052.94 Median:3103.01 stddev:100818.73 (3249.1%) stddev-sans-first:101069.80 14:38:37 INFO - PROCESS | 1959 | Values: 351.9 358.1 360.0 362.6 369.6 19174.8 19469.4 20619.0 20643.7 20646.8 11415.4 19417.5 19715.7 19876.7 19903.2 5217.4 5372.2 5403.2 5426.9 5428.5 3989.0 5339.4 5802.6 6054.2 6059.5 5928.3 6006.8 6052.2 6054.3 6065.2 5780.7 5929.5 5984.1 5987.0 5990.6 5634.0 5673.9 5679.9 5687.8 5695.7 11243.7 11282.6 13038.9 13646.0 13706.6 1676.8 1978.0 1986.1 2216.6 2218.1 7422.6 9410.2 9651.3 9885.0 10232.0 1414.6 1588.8 1665.4 1674.0 1706.7 101260.0 109982.0 110934.9 111248.0 113254.0 10789.5 11097.6 11177.1 11253.9 11284.3 13451.7 13527.2 13546.7 13563.3 13568.7 8330.6 8332.3 8528.6 8542.8 8559.2 8550.8 8567.1 8588.8 8658.7 8751.6 4467.3 4503.2 4503.3 4531.8 4641.7 1793.0 1878.2 2936.6 3269.4 3544.2 659.7 834.3 898.8 935.3 1003.0 18212.5 18274.3 19270.0 19877.1 19943.3 915.5 925.2 934.6 959.4 992.7 10316.2 10486.3 10542.9 10569.4 10608.2 596647.0 601073.0 606611.7 607551.0 620452.0 100170.5 118903.0 120723.0 122463.4 125142.0 997.3 1017.9 1026.8 1031.9 1034.5 14532.5 17602.2 17671.0 17856.8 18090.8 39406.6 53673.0 54047.0 54051.2 55210.0 76999.0 77561.0 77652.2 77753.6 79423.6 7970.2 7995.7 8147.6 8161.8 8308.2 11633.7 12147.9 12674.9 12991.4 13068.7 9625.7 10676.7 11059.0 11180.4 11381.4 9127.0 10818.2 10981.1 11193.9 11263.7 9026.5 11330.8 11380.5 11519.4 11531.9 7983.3 8052.2 8103.4 8353.1 8359.6 10849.0 11139.6 11261.7 11292.2 11414.8 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - PROCESS | 1959 | [#3] mootools.html Cycles:180 Average:5859.47 Median:5367.95 stddev:3102.72 (57.8%) stddev-sans-first:3092.91 14:38:37 INFO - PROCESS | 1959 | Values: 1350.8 1361.3 1538.1 1642.8 1792.2 7044.6 7775.4 7790.7 8699.7 8715.5 6835.0 8469.6 8548.0 8571.5 8589.0 2433.4 2448.0 2448.7 2448.9 2464.2 2238.6 2240.9 2441.2 2456.9 2463.3 2421.1 2425.8 2445.1 2449.0 2459.4 2416.7 2428.7 2428.8 2439.8 2461.7 2174.7 2302.5 2344.5 2397.6 2402.5 8629.0 8650.2 8654.9 8679.7 8691.7 5213.4 5342.6 5356.6 5358.4 5361.1 3524.5 3576.5 3642.9 3670.4 3675.8 1048.3 1065.2 1068.4 1071.4 1072.6 11512.2 11641.4 11644.5 11666.7 11673.4 4733.5 4738.5 4828.7 4846.5 4870.8 9724.1 9754.6 9831.9 9848.7 9886.1 5332.9 5354.9 5374.8 5386.3 5389.6 4333.4 4714.9 4839.7 4889.3 4906.4 3803.4 3867.6 3868.9 3903.3 3913.1 1273.1 1276.6 1277.2 1283.5 1287.6 1016.9 1024.6 1024.7 1142.7 1339.1 7846.9 7862.5 7898.9 7967.7 7983.8 476.2 479.9 481.2 483.5 483.6 5928.3 5941.0 6111.7 6162.9 6184.9 8605.0 10236.6 10429.3 10471.6 10623.0 10373.3 10403.6 10410.9 10459.7 10488.8 7950.4 8255.8 8294.1 8299.6 8346.4 7716.5 7720.5 7728.0 7746.3 7756.2 9086.9 9097.7 9112.2 9301.8 9357.0 9471.1 9477.3 9478.3 9563.8 9828.3 6054.8 6668.3 7295.5 7381.0 7486.7 6369.4 7993.0 8016.6 8022.0 8036.8 6987.0 7145.0 7172.3 7232.7 7318.2 6119.7 6975.6 7022.4 7081.7 7116.6 7526.8 7529.0 7561.3 7572.5 7619.6 6908.1 6924.2 6931.2 6970.8 6991.0 6956.2 7023.7 7027.6 7038.4 7060.0 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - PROCESS | 1959 | [#4] prototype.html Cycles:180 Average:5947.42 Median:6794.65 stddev:1952.27 (28.7%) stddev-sans-first:1911.52 14:38:37 INFO - PROCESS | 1959 | Values: 320.7 323.6 325.8 330.0 331.3 6793.3 6883.1 6901.7 6908.3 6947.0 6659.8 6707.7 6716.4 6727.5 6796.0 4766.0 4878.9 4968.7 5006.6 5043.0 4984.5 4990.9 5014.4 5026.3 5027.9 4505.5 4737.1 4931.4 4956.9 4958.5 4937.6 4943.6 4944.8 4949.0 4980.5 4254.4 4272.7 4276.8 4293.9 4300.9 6086.9 6242.3 6544.2 6549.7 6573.4 5721.3 5756.8 5758.8 5767.4 5787.5 7279.7 7292.7 7299.2 7300.7 7304.8 3906.4 4636.0 4642.9 4643.2 4643.9 7325.6 7659.1 7677.0 7685.4 7717.8 4054.9 4330.0 4507.2 4584.9 4670.4 3924.0 4726.0 4751.0 4777.0 4782.3 5690.4 5706.8 5707.3 5721.1 5726.3 7226.6 7240.2 7309.3 7337.3 7340.1 1640.8 1669.2 1676.0 1677.0 1682.6 1020.1 1066.4 1067.2 1067.6 1072.2 6765.9 6802.7 6824.0 6825.0 6831.3 7643.0 7649.2 7668.7 7669.7 7674.0 5611.3 6518.0 6811.2 6815.1 6829.1 3938.6 4018.9 4049.9 4061.8 4073.4 6976.4 7398.3 7960.7 8027.2 8031.6 6860.4 7903.9 7959.0 7985.1 7999.6 8009.4 8020.8 8025.8 8042.0 8052.8 7368.8 7716.4 7733.1 7733.4 7769.8 7562.1 7601.7 7609.8 7622.2 7638.8 6491.8 7988.6 7999.4 8036.4 8055.0 4706.6 4762.2 4762.4 4764.3 4780.9 7349.9 7539.8 7647.5 7666.9 7708.3 5980.8 7345.6 7377.9 7404.9 7410.2 7401.3 7402.0 7418.9 7434.8 7437.7 6983.6 7228.5 7234.3 7245.7 7246.0 6063.5 7384.8 7403.0 7429.8 7434.2 7097.7 7241.9 7244.9 7274.1 7281.3 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - PROCESS | 1959 | [#5] yui.html Cycles:180 Average:17234.55 Median:31847.06 stddev:23484.59 (73.7%) stddev-sans-first:23517.54 14:38:37 INFO - PROCESS | 1959 | Values: 672.4 703.3 720.1 729.2 737.9 14592.5 14882.5 14902.9 14947.7 14975.9 13616.1 13642.6 15522.7 15812.5 15923.0 721.6 869.3 874.5 880.4 881.4 868.2 891.6 897.2 899.0 902.7 918.9 929.1 932.3 939.6 941.1 900.9 918.4 929.8 932.9 933.5 660.6 677.1 690.6 693.6 696.2 15163.8 15176.7 15184.4 15255.7 15291.9 12326.2 12393.2 12416.6 12564.9 12597.7 8456.4 9883.5 9952.7 10041.6 10341.1 3478.8 3519.5 3539.3 3544.6 3554.1 68933.0 76534.9 81828.6 82472.8 83173.0 9366.1 9367.3 9402.9 9472.4 9610.7 21759.5 21820.7 22090.9 22132.9 22134.0 6498.6 7379.4 7450.2 7528.1 7591.9 3979.1 4018.7 4062.7 4068.0 4079.4 3522.8 3525.9 3555.8 3569.2 3572.3 606.9 614.3 659.1 661.2 662.6 477.4 573.3 577.8 582.7 623.4 8074.3 8082.8 8156.3 8182.6 8304.1 569.5 579.5 599.4 614.2 615.7 3615.8 3643.3 3771.9 3822.5 3850.3 79443.8 79709.0 81350.2 81441.6 81536.6 72814.9 73505.6 73742.6 73913.5 74393.0 64005.0 64206.4 65114.7 65535.0 66028.7 7572.7 7575.3 7616.5 7668.6 7835.5 45193.3 46321.0 46693.5 46699.8 47203.0 45678.8 58089.0 59263.4 62127.1 63070.7 9767.6 9860.9 10969.6 11297.8 11366.3 11780.2 11938.2 12055.8 12194.5 12545.7 11070.6 11076.2 11411.0 11444.0 11576.3 11085.6 11253.7 11360.2 11586.5 11890.6 10640.6 10926.6 11078.6 11194.9 11374.3 9180.5 9456.1 9590.1 9590.8 9765.1 7770.8 9203.0 9272.8 9383.5 9443.9 14:38:37 INFO - PROCESS | 1959 | -------- Summary: end -------- 14:38:37 INFO - PROCESS | 1959 | 14:38:37 INFO - TEST-INFO | 1959: exit 0 14:38:37 INFO - TEST-OK | dromaeo_css | took 1110589ms 14:38:37 INFO - TEST-START | kraken 14:38:37 INFO - operating with platform_type : mac_ 14:38:37 INFO - Initialising browser for kraken test... 14:38:37 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp0YiO7g/profile http://localhost:49599/getInfo.html) 14:38:40 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 14:38:40 INFO - PROCESS | 1964 | colorDepth:24 14:38:40 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 14:38:40 INFO - PROCESS | 1964 | __metrics 14:38:40 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:38:40 INFO - TEST-INFO | 1964: exit 0 14:38:40 INFO - Browser initialized. 14:38:40 INFO - Running cycle 1/1 for kraken test... 14:38:40 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp0YiO7g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:53 INFO - PROCESS | 1967 | RSS: Main: 253956096 14:38:53 INFO - PROCESS | 1967 | 14:38:55 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49599/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:56 INFO - PROCESS | 1967 | RSS: Main: 268828672 14:38:56 INFO - PROCESS | 1967 | 14:38:59 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49599/tests/kraken/driver.html?testName=audio-dft) 14:38:59 INFO - PROCESS | 1967 | RSS: Main: 276783104 14:38:59 INFO - PROCESS | 1967 | 14:39:02 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49599/tests/kraken/driver.html?testName=audio-fft) 14:39:03 INFO - PROCESS | 1967 | RSS: Main: 279339008 14:39:03 INFO - PROCESS | 1967 | 14:39:05 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49599/tests/kraken/driver.html?testName=audio-oscillator) 14:39:06 INFO - PROCESS | 1967 | RSS: Main: 280027136 14:39:06 INFO - PROCESS | 1967 | 14:39:08 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49599/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:39:08 INFO - PROCESS | 1967 | RSS: Main: 282423296 14:39:08 INFO - PROCESS | 1967 | 14:39:11 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49599/tests/kraken/driver.html?testName=imaging-darkroom) 14:39:12 INFO - PROCESS | 1967 | RSS: Main: 283643904 14:39:12 INFO - PROCESS | 1967 | 14:39:15 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49599/tests/kraken/driver.html?testName=imaging-desaturate) 14:39:15 INFO - PROCESS | 1967 | RSS: Main: 283512832 14:39:15 INFO - PROCESS | 1967 | 14:39:18 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49599/tests/kraken/driver.html?testName=json-parse-financial) 14:39:19 INFO - PROCESS | 1967 | RSS: Main: 283627520 14:39:19 INFO - PROCESS | 1967 | 14:39:20 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49599/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:39:21 INFO - PROCESS | 1967 | RSS: Main: 283742208 14:39:21 INFO - PROCESS | 1967 | 14:39:23 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49599/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:39:23 INFO - PROCESS | 1967 | RSS: Main: 282722304 14:39:23 INFO - PROCESS | 1967 | 14:39:26 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49599/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:39:26 INFO - PROCESS | 1967 | RSS: Main: 282877952 14:39:26 INFO - PROCESS | 1967 | 14:39:29 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:39:29 INFO - PROCESS | 1967 | RSS: Main: 282263552 14:39:29 INFO - PROCESS | 1967 | 14:39:32 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:39:33 INFO - PROCESS | 1967 | RSS: Main: 284434432 14:39:33 INFO - PROCESS | 1967 | 14:39:34 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49599/tests/kraken/driver.html?testName=ai-astar) 14:39:35 INFO - PROCESS | 1967 | RSS: Main: 284135424 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | __start_tp_report 14:39:35 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 14:39:35 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 14:39:35 INFO - PROCESS | 1967 | |i|pagename|runs| 14:39:35 INFO - PROCESS | 1967 | |0;ai-astar;114;108;113;114;116;123;115;116;115;113 14:39:35 INFO - PROCESS | 1967 | |1;audio-beat-detection;158;123;154;193;124;144;140;122;159;132 14:39:35 INFO - PROCESS | 1967 | |2;audio-dft;192;224;276;230;206;198;196;196;198;187 14:39:35 INFO - PROCESS | 1967 | |3;audio-fft;70;76;71;115;63;77;83;87;139;57 14:39:35 INFO - PROCESS | 1967 | |4;audio-oscillator;83;83;119;79;78;81;119;79;80;120 14:39:35 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;94;87;88;132;135;85;90;85;100;116 14:39:35 INFO - PROCESS | 1967 | |6;imaging-darkroom;93;95;95;99;95;94;95;95;94;132 14:39:35 INFO - PROCESS | 1967 | |7;imaging-desaturate;151;94;94;92;92;96;90;92;116;137 14:39:35 INFO - PROCESS | 1967 | |8;json-parse-financial;55;55;54;53;61;63;83;61;88;84 14:39:35 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;62;64;74;72;67;69;84;100;100;62 14:39:35 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;87;85;86;83;83;85;85;84;85;84 14:39:35 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;132;136;145;135;132;139;121;134;146;144 14:39:35 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;143;142;144;130;173;188;136;138;140;145 14:39:35 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;66;71;68;72;99;100;92;72;66;68 14:39:35 INFO - PROCESS | 1967 | __end_tp_report 14:39:35 INFO - PROCESS | 1967 | __start_cc_report 14:39:35 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,899 14:39:35 INFO - PROCESS | 1967 | __end_cc_report 14:39:35 INFO - PROCESS | 1967 | __startTimestamp1456958375128__endTimestamp 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | ------- Summary: start ------- 14:39:35 INFO - PROCESS | 1967 | Number of tests: 14 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:3.71 (3.2%) stddev-sans-first:3.93 14:39:35 INFO - PROCESS | 1967 | Values: 114.0 108.0 113.0 114.0 116.0 123.0 115.0 116.0 115.0 113.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:149.00 stddev:22.11 (14.8%) stddev-sans-first:22.94 14:39:35 INFO - PROCESS | 1967 | Values: 158.0 123.0 154.0 193.0 124.0 144.0 140.0 122.0 159.0 132.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:210.30 Median:202.00 stddev:26.87 (13.3%) stddev-sans-first:27.68 14:39:35 INFO - PROCESS | 1967 | Values: 192.0 224.0 276.0 230.0 206.0 198.0 196.0 196.0 198.0 187.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:83.80 Median:73.50 stddev:25.04 (34.1%) stddev-sans-first:26.06 14:39:35 INFO - PROCESS | 1967 | Values: 70.0 76.0 71.0 115.0 63.0 77.0 83.0 87.0 139.0 57.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:79.50 stddev:18.86 (23.7%) stddev-sans-first:19.72 14:39:35 INFO - PROCESS | 1967 | Values: 83.0 83.0 119.0 79.0 78.0 81.0 119.0 79.0 80.0 120.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:101.20 Median:86.00 stddev:19.41 (22.6%) stddev-sans-first:20.41 14:39:35 INFO - PROCESS | 1967 | Values: 94.0 87.0 88.0 132.0 135.0 85.0 90.0 85.0 100.0 116.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:95.00 stddev:11.80 (12.4%) stddev-sans-first:12.34 14:39:35 INFO - PROCESS | 1967 | Values: 93.0 95.0 95.0 99.0 95.0 94.0 95.0 95.0 94.0 132.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:105.40 Median:92.00 stddev:21.89 (23.8%) stddev-sans-first:15.83 14:39:35 INFO - PROCESS | 1967 | Values: 151.0 94.0 94.0 92.0 92.0 96.0 90.0 92.0 116.0 137.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:62.00 stddev:13.78 (22.2%) stddev-sans-first:14.07 14:39:35 INFO - PROCESS | 1967 | Values: 55.0 55.0 54.0 53.0 61.0 63.0 83.0 61.0 88.0 84.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:75.40 Median:68.00 stddev:14.52 (21.4%) stddev-sans-first:14.57 14:39:35 INFO - PROCESS | 1967 | Values: 62.0 64.0 74.0 72.0 67.0 69.0 84.0 100.0 100.0 62.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:1.25 (1.5%) stddev-sans-first:1.01 14:39:35 INFO - PROCESS | 1967 | Values: 87.0 85.0 86.0 83.0 83.0 85.0 85.0 84.0 85.0 84.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:137.50 stddev:7.56 (5.5%) stddev-sans-first:7.85 14:39:35 INFO - PROCESS | 1967 | Values: 132.0 136.0 145.0 135.0 132.0 139.0 121.0 134.0 146.0 144.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:143.50 stddev:18.08 (12.6%) stddev-sans-first:19.09 14:39:35 INFO - PROCESS | 1967 | Values: 143.0 142.0 144.0 130.0 173.0 188.0 136.0 138.0 140.0 145.0 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:71.50 stddev:13.85 (19.4%) stddev-sans-first:14.06 14:39:35 INFO - PROCESS | 1967 | Values: 66.0 71.0 68.0 72.0 99.0 100.0 92.0 72.0 66.0 68.0 14:39:35 INFO - PROCESS | 1967 | -------- Summary: end -------- 14:39:35 INFO - PROCESS | 1967 | 14:39:35 INFO - TEST-INFO | 1967: exit 0 14:39:35 INFO - TEST-OK | kraken | took 58299ms 14:39:35 INFO - SUITE-END | took 1168s 14:39:36 INFO - Completed test suite (00:19:29) 14:39:36 INFO - Working with test: dromaeo_css 14:39:36 INFO - Generating results file: dromaeo_css 14:39:36 INFO - Working with test: kraken 14:39:36 INFO - Generating results file: kraken 14:39:36 INFO - javascript benchmark 14:39:36 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:39:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 14:39:36 INFO - process_Request line: dromaeo_css 7401.93 graph.html#tests=[[72,64,61]] 14:39:36 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:39:36 INFO - process_Request line: kraken 1538.60 graph.html#tests=[[232,64,61]] 14:39:36 INFO - RETURN: dromaeo_css: 7401.93 14:39:36 INFO - RETURN: kraken: 1538.60 14:39:36 INFO - javascript benchmark 14:39:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3475.1312171957006, 3478.0956951192684, 3501.0372147659373, 3544.787312761234, 3545.9645403545956, 5451.509364157225, 5676.063449530833, 5691.288588926384, 5692.203091567184, 5718.685472299022, 5523.944760552393, 5591.664500129995, 5696.601237913348, 5725.541956643469, 5746.626469279494, 4967.882226499027, 5122.974385128069, 5143.151380022292, 5203.011427828719, 5204.375474943012, 4222.282212023963, 4696.624270058387, 5215.113430716769, 5277.70972596507, 5280.656757310781, 5047.49525047496, 5057.5701065409485, 5126.53861152498, 5163.096458119851, 5186.740662966837, 5179.637425380225, 5181.093308670967, 5191.2472691459525, 5206.7917283308625, 5242.0, 4288.892777680552, 4469.932951005738, 4757.5718185363485, 5097.974510127426, 5176.378834539842, 5468.589855760833, 5552.139418390116, 5603.971980140114, 5626.127950167731, 5651.8304450866535, 6188.628682279078, 6208.906866397007, 6220.098085777582, 6245.156903817971, 6245.313015568284, 6105.175801266817, 6183.876322473526, 6199.318075011745, 6202.844928876769, 6206.6586337751405, 5760.654360738369, 5835.708214589254, 5853.356130825606, 5858.326292476378, 5871.735771890275, 6212.0, 6214.8135555933395, 6227.19046523949, 6257.374262573706, 6262.592931459531, 5897.439743224472, 6101.115338275925, 6141.140240366352, 6179.351168127282, 6187.16473276111, 5142.382914050263, 6118.755249789959, 6136.1821086261625, 6157.983932651063, 6182.474489668339, 6138.294096178907, 6145.262568491809, 6157.0, 6164.4143806338325, 6168.19813424252, 6090.604110732788, 6191.19514463117, 6203.503719702413, 6208.1308616793685, 6214.658193799294, 4817.181079216542, 4915.557599816034, 4918.778654960535, 4929.162042452792, 4964.478729733398, 4355.107203023373, 4375.649948004216, 4379.321205213197, 4419.359192917009, 4457.4205353304515, 5577.9163312550345, 5590.496855283044, 5663.745131469093, 5690.516306113944, 5691.089425691869, 6123.679189354777, 6168.074788781629, 6187.504999600022, 6207.96896015517, 6232.127502149703, 5672.347680016768, 5685.658860468385, 5692.402297758676, 5702.771889124471, 5754.021816291241, 5203.2195170723935, 5321.86695332612, 5349.679019258857, 5367.865803354947, 5387.838364849061, 6234.438900498886, 6251.3123556408755, 6257.5932564383165, 6259.280182779039, 6273.811785646438, 6188.133661287334, 6209.0, 6223.315435302204, 6228.159198508325, 6232.626042437469, 6131.896637733107, 6146.446819786241, 6170.352113028068, 6178.41305076017, 6229.4393504584805, 6112.022076467744, 6128.908066379097, 6160.661163636043, 6163.722632481459, 6186.659733714689, 6154.476869466145, 6184.752609895554, 6204.5967012144065, 6220.533459990428, 6225.595336303126, 5795.782885593904, 6019.969900150471, 6083.087536869505, 6097.0, 6132.936844521141, 6063.029915213545, 6063.818085457443, 6067.574120081689, 6068.332483426731, 6070.666113363807, 4846.860987667966, 5550.028744969695, 5868.295804503487, 5925.614835035709, 5938.287405511366, 5038.496150384932, 6020.8795824084145, 6101.671357587221, 6127.938720612737, 6133.969330153321, 5964.403559644001, 5975.462208401264, 5976.193213916065, 5987.2815262168815, 6018.638881667114], "unit": "score", "name": "dojo.html", "value": 5630.697124805547}, {"lowerIsBetter": false, "replicates": [528.281537109531, 561.6237121128845, 562.8198976327574, 595.520605912241, 653.2552889705736, 29303.706962930366, 37138.44292335617, 37166.44250336247, 37223.441648375265, 37230.88307350784, 32894.34211315772, 35878.2824343513, 37837.86486405412, 38508.42237366442, 39329.0, 9345.392549484295, 9494.240460763122, 9566.330356875022, 9573.42559446432, 9582.99378565251, 9379.718608441757, 9535.094166054214, 9613.567389467456, 9627.085426884434, 9651.565679544403, 9578.808423831519, 9651.420914745138, 9658.275629327793, 9666.903330966707, 9691.982341854075, 9510.33427660064, 9547.997460266675, 9587.376820506715, 9632.759181020461, 9640.80718385632, 9442.716718498456, 9561.422365309716, 9573.569189386495, 9589.42463452195, 9597.560365945094, 37156.0, 37325.25349492995, 37528.43707344392, 37532.81233593842, 37599.24801503982, 3110.28463453407, 3143.3398986212924, 3289.3092450585405, 3337.933241335184, 3393.100828280508, 27810.16569502918, 27839.0, 28255.858720706266, 28383.57424638632, 28477.57283640747, 2666.373402250489, 2734.0, 2746.945061098767, 2768.3909539901188, 2778.2082106599523, 414168.0, 417893.0, 418318.0, 419073.80926190654, 419664.0, 48431.0, 50704.492955069974, 62266.0, 62316.68841655763, 62356.0, 66385.0, 70004.0, 70476.64761676159, 70514.0, 70876.0, 15967.121808300655, 16028.599285017735, 16082.919585402233, 16242.0, 16287.267072981744, 10010.799784004279, 10385.324953877975, 12048.578299759467, 12251.0, 12337.814932776015, 20448.284310049075, 20781.89609051945, 20783.0, 20798.37604871856, 21623.0, 7891.210878912178, 8739.388242823068, 8785.341099417441, 9062.50156241413, 9104.408213466104, 913.3378300731916, 942.9434233945985, 957.1003256938455, 960.2366118935463, 1007.6976906927893, 27913.720862791113, 29035.854820725763, 29196.124116276547, 29445.411091778045, 29643.85178074096, 986.4328011393477, 1039.7140786283833, 1078.7680648660576, 1082.9187810914214, 1145.2326940949417, 14023.08849924772, 14224.217668028357, 14225.715485690229, 14372.784408233885, 14380.065295755743, 492449.0, 494360.0, 497296.0, 500637.0, 501279.0, 45423.09153816905, 55144.172837407474, 57150.0, 57255.14117288244, 57353.27940161718, 1354.9187048777105, 1361.598328493097, 1361.6731984323692, 1381.696026874106, 1391.0123812093325, 25113.0, 25530.617040744775, 26735.732642673323, 27472.313192170357, 27987.44025119527, 46696.766516167205, 46936.7653161732, 47080.05839883115, 47508.0, 47577.04845903132, 440908.59091408673, 443056.0, 445744.0, 448590.0, 450054.0, 32659.673403265664, 32720.509192361656, 32734.0, 33129.50305745367, 33371.499427509094, 43635.345469817345, 43687.78156109199, 43709.344359833995, 44018.33972490479, 44174.55825441833, 30225.201550925907, 32644.34711305808, 35975.460368093976, 37172.256554869295, 37384.252314954094, 35998.0, 36243.45634815427, 36528.26943461169, 36579.0, 36658.63341366552, 28699.282517936383, 36707.08232294214, 36850.8157459211, 36945.63054369422, 37853.62146378611, 28011.0, 29850.552241715955, 31040.0687979361, 31215.84392078025, 31909.20226994344, 23671.52656946817, 23869.761302386753, 23963.0, 24255.75744242535, 24563.385915351544], "unit": "score", "name": "ext.html", "value": 19108.312255784826}, {"lowerIsBetter": false, "replicates": [351.89267273481596, 358.1404628890662, 359.98380072896725, 362.60657186952153, 369.61006138523845, 19174.808251917475, 19469.415917522463, 20618.9690515474, 20643.69034464484, 20646.793532064676, 11415.42922853856, 19417.514562135955, 19715.704264436044, 19876.701849472232, 19903.203871845144, 5217.399999000107, 5372.167314066306, 5403.2165336026255, 5426.864328391802, 5428.538574221196, 3989.0, 5339.439358867321, 5802.564807639423, 6054.243219597551, 6059.545534084939, 5928.258967629046, 6006.7897623583185, 6052.243469566304, 6054.273487181545, 6065.181200537937, 5780.739866706008, 5929.517620594851, 5984.102384642295, 5987.0, 5990.640561566276, 5633.971830140864, 5673.914891276634, 5679.943200567983, 5687.772489100473, 5695.7152142392715, 11243.662690119229, 11282.605108821152, 13038.86961130386, 13646.0, 13706.588802335946, 1676.8071671757782, 1977.9703304450445, 1986.1161783006569, 2216.5788500184913, 2218.057325636598, 7422.6288685565505, 9410.153086222273, 9651.276154288456, 9885.0, 10232.02795734404, 1414.6109819799535, 1588.8411158884135, 1665.4337525241476, 1674.045793897479, 1706.6586682663517, 101260.0, 109982.0, 110934.89065109326, 111248.0, 113254.0, 10789.460526973777, 11097.55609775616, 11177.105831533458, 11253.943730281297, 11284.32294062359, 13451.730965380833, 13527.188368697909, 13546.729065418833, 13563.321833908265, 13568.660783480294, 8330.62512186953, 8332.291755200877, 8528.616212270463, 8542.829143417097, 8559.186877246651, 8550.78623034429, 8567.143285671384, 8588.847583643123, 8658.740237792876, 8751.649934002697, 4467.329900514948, 4503.211937910853, 4503.256962601135, 4531.77341132942, 4641.698289611232, 1793.0, 1878.1548303263587, 2936.6182396288345, 3269.4115059289556, 3544.2379888324135, 659.6606610473348, 834.2908527751484, 898.81574277273, 935.2751617496359, 1002.9539738932642, 18212.45362639123, 18274.26902923895, 19270.0, 19877.105530251174, 19943.301984430476, 915.5102020419043, 925.2043242811177, 934.6121359635675, 959.3907868503411, 992.7071513903416, 10316.226283028804, 10486.318389304672, 10542.947285263677, 10569.365838049742, 10608.20438467118, 596647.0, 601073.0, 606611.7024733898, 607551.0, 620452.0, 100170.49914750525, 118903.0, 120723.0, 122463.38768306101, 125142.0, 997.2620261006803, 1017.8803316351954, 1026.820306446369, 1031.9174466042698, 1034.4517405774952, 14532.491362802251, 17602.207900644757, 17671.028093454985, 17856.821431785516, 18090.819091808913, 39406.60593394144, 53673.0, 54047.0, 54051.18923216076, 55210.0, 76999.0, 77561.0, 77652.2234777645, 77753.61123194348, 79423.60288198522, 7970.163132871197, 7995.720149794729, 8147.592620369076, 8161.836763264821, 8308.169183081643, 11633.709157271136, 12147.939260303641, 12674.936625317183, 12991.35043247815, 13068.673283167996, 9625.71122866315, 10676.733081673021, 11059.0, 11180.385078820744, 11381.43092845371, 9126.954365228132, 10818.1886358525, 10981.121510279318, 11193.944030279796, 11263.66209013731, 9026.548672566214, 11330.773384532427, 11380.54477820878, 11519.366434846164, 11531.94627127429, 7983.281504664608, 8052.194780521901, 8103.432759706764, 8353.081161072156, 8359.623816928131, 10849.0, 11139.554417823196, 11261.66215013551, 11292.153088518558, 11414.771704565695], "unit": "score", "name": "jquery.html", "value": 9155.025285927803}, {"lowerIsBetter": false, "replicates": [1350.7906274527445, 1361.2921280933915, 1538.092525410008, 1642.819289878114, 1792.2024699008946, 7044.577325360476, 7775.416843736728, 7790.727324543628, 8699.652013919436, 8715.477071375713, 6834.96582517088, 8469.618867150977, 8547.957260213705, 8571.528565928871, 8588.95705521473, 2433.3916520869784, 2447.9755202447927, 2448.7061552613714, 2448.8897999590063, 2464.2484042367073, 2238.563480121377, 2240.8571628469435, 2441.218809980807, 2456.9017239310406, 2463.3102731235194, 2421.079989603948, 2425.8059355251626, 2445.1075357494565, 2449.0448724997264, 2459.4220358215807, 2416.66166736657, 2428.672129262545, 2428.7571242875747, 2439.841410308324, 2461.692288463942, 2174.68431598882, 2302.458922153293, 2344.542814151241, 2397.6043952747777, 2402.531506356261, 8628.956855215747, 8650.178233067849, 8654.913450865537, 8679.739607811776, 8691.652333906635, 5213.4004589472315, 5342.626016178869, 5356.625036247464, 5358.410574836765, 5361.08861493547, 3524.4537096750046, 3576.535050443452, 3642.9453558196647, 3670.4127339625534, 3675.8345874435713, 1048.26621365044, 1065.2010991756183, 1068.4444089073638, 1071.3839542263152, 1072.6406653770996, 11512.194146409754, 11641.41792910351, 11644.475998580085, 11666.708332291675, 11673.357965311905, 4733.532604892425, 4738.5261473853025, 4828.66199366041, 4846.5153484651255, 4870.829520966749, 9724.076212759777, 9754.634351190838, 9831.901680983241, 9848.655297064568, 9886.110250077527, 5332.866678333073, 5354.9464505354445, 5374.811881584125, 5386.272853164773, 5389.649672771257, 4333.414988976511, 4714.858554243378, 4839.661223714306, 4889.291052797395, 4906.386701662293, 3803.353429916921, 3867.57456679765, 3868.9226215476097, 3903.277893589695, 3913.099987003005, 1273.064297741178, 1276.6361586947676, 1277.1698396042646, 1283.4994352202648, 1287.620152055146, 1016.903394177552, 1024.5799222318813, 1024.6669832304383, 1142.7428828513684, 1339.1161833190242, 7846.882296765553, 7862.52824830512, 7898.881516777253, 7967.721129760431, 7983.8403231935035, 476.19760703215195, 479.8776312040477, 481.24684868181885, 483.45128279403133, 483.6300230323805, 5928.318243401977, 5941.0, 6111.724972376253, 6162.876742465126, 6184.938150618436, 8604.956975215084, 10236.641717539851, 10429.322094064013, 10471.633492827714, 10623.043926046694, 10373.325733827278, 10403.63587274457, 10410.947945260225, 10459.738506537245, 10488.842667359995, 7950.403719721044, 8255.793605159919, 8294.129116442688, 8299.585020748938, 8346.4157508975, 7716.498427602188, 7720.498167619086, 7727.9953606033105, 7746.341560967381, 7756.224377562198, 9086.909130908607, 9097.727068187965, 9112.225460835904, 9301.813963720822, 9357.01751316102, 9471.052894710474, 9477.289203309641, 9478.336516443782, 9563.808723825345, 9828.31201815866, 6054.8183554493435, 6668.266490686117, 7295.489315747846, 7380.96309518449, 7486.7005319786595, 6369.363063693593, 7993.0, 8016.6392512335915, 8021.959890200512, 8036.799080023046, 6987.0, 7145.035420218204, 7172.282771722786, 7232.674529646073, 7318.231585683639, 6119.694015299128, 6975.581465112109, 7022.367986881, 7081.68132434052, 7116.644167791694, 7526.811829704301, 7529.0, 7561.281678240558, 7572.507786993828, 7619.619019049136, 6908.067410899464, 6924.169099708067, 6931.202911665021, 6970.825729356807, 6990.965045174741, 6956.200036995608, 7023.719051237893, 7027.61348125858, 7038.40173585251, 7059.964700176466], "unit": "score", "name": "mootools.html", "value": 4690.428415517997}, {"lowerIsBetter": false, "replicates": [320.7289840085128, 323.6294442862922, 325.80614534352054, 329.95545601343827, 331.25963471640887, 6793.286704895982, 6883.070785443963, 6901.654917254143, 6908.343707347806, 6947.0, 6659.833504162386, 6707.664616769166, 6716.395524402803, 6727.461803055756, 6796.014577886203, 4765.976170119145, 4878.878028049292, 4968.726720030415, 5006.5744411725045, 5043.016611760708, 4984.451710311862, 4990.850274491771, 5014.398272207322, 5026.2711906773675, 5027.899442011158, 4505.504394516601, 4737.147313483571, 4931.408231012284, 4956.925646115311, 4958.528939750736, 4937.580305674022, 4943.629227807911, 4944.826931057396, 4949.034938187055, 4980.501949805027, 4254.404383386297, 4272.6795490338345, 4276.828926842923, 4293.914121717579, 4300.935485967713, 6086.9391306087255, 6242.344553821828, 6544.181977252843, 6549.672516374162, 6573.408393244631, 5721.313442386899, 5756.762296106315, 5758.798442054508, 5767.394423585547, 5787.450192231731, 7279.708811647528, 7292.74475393364, 7299.160596531361, 7300.7444739434395, 7304.780856574312, 3906.374980003214, 4635.95364046362, 4642.930356044662, 4643.210654188796, 4643.907121857544, 7325.597092159983, 7659.119201291867, 7676.9616151919445, 7685.42359323053, 7717.807054823675, 4054.9391759123637, 4330.0040990571715, 4507.166174257773, 4584.908301833944, 4670.416197975253, 3923.9607603923596, 4726.031163611451, 4751.049790041936, 4776.95223047772, 4782.258749893772, 5690.402507736628, 5706.771729130871, 5707.34365547959, 5721.056025755787, 5726.255586773693, 7226.566406015656, 7240.2035776064595, 7309.305615966475, 7337.266273372727, 7340.119185697644, 1640.753886916972, 1669.2321532095373, 1675.9581010474592, 1676.983230167707, 1682.6045879218375, 1020.0717347213999, 1066.3548553125402, 1067.2422579968309, 1067.64767626683, 1072.1637123044038, 6765.864682706417, 6802.727890884408, 6823.965880170567, 6824.965875170592, 6831.316868313129, 7643.044619422572, 7649.235076492418, 7668.702457943026, 7669.7315593953945, 7674.002379690604, 5611.298587676541, 6517.95712685968, 6811.2167100784045, 6815.148106486689, 6829.112215411965, 3938.6061393860386, 4018.8794336169963, 4049.8582549610624, 4061.7969101544804, 4073.4093556434746, 6976.372126508639, 7398.3341499265325, 7960.681572737026, 8027.237412445808, 8031.55826429552, 6860.3825655690225, 7903.9209607903185, 7958.960205199052, 7985.121636619967, 7999.640016199285, 8009.399295052895, 8020.799480013046, 8025.799355016171, 8041.9947506561675, 8052.798680033046, 7368.815779605553, 7716.382689384724, 7733.110692270461, 7733.419993500397, 7769.844603108019, 7562.054743157106, 7601.695932162652, 7609.771706848804, 7622.237776222333, 7638.847223055619, 6491.772787952399, 7988.6405111768945, 7999.400044996532, 8036.357091432555, 8055.0, 4706.552877476634, 4762.190427627381, 4762.3570817939135, 4764.2615394613895, 4780.856574302777, 7349.853002939804, 7539.811504712426, 7647.464677472523, 7666.923330766844, 7708.306252437307, 5980.790672326448, 7345.5959922202655, 7377.897299269683, 7404.888926665996, 7410.184879663125, 7401.259874012556, 7402.037735094618, 7418.925810741824, 7434.7769566913075, 7437.665305061177, 6983.580985140908, 7228.530145540523, 7234.348908598251, 7245.673944672397, 7246.0, 6063.454289114001, 7384.818429051541, 7402.962985185255, 7429.8142546436775, 7434.182239953492, 7097.716091356495, 7241.927580724336, 7244.927550724636, 7274.127104747464, 7281.308275713799], "unit": "score", "name": "prototype.html", "value": 5287.745212536906}, {"lowerIsBetter": false, "replicates": [672.3914857054366, 703.2896774257998, 720.0639169080196, 729.1541811498663, 737.9372753315968, 14592.4892628758, 14882.479113231038, 14902.850971490281, 14947.701045979074, 14975.87680923931, 13616.114952528078, 13642.590722278323, 15522.689546209069, 15812.525624231292, 15923.0, 721.5923003503004, 869.326272139091, 874.5059041641468, 880.4321212817729, 881.4446898453997, 868.2099289646424, 891.6388862510661, 897.1521911793358, 899.0470101692194, 902.6524787956652, 918.912703293186, 929.066288380177, 932.2868005975434, 939.5865819039635, 941.1200527506769, 900.9234215091725, 918.3525614441869, 929.809389075238, 932.9486878221695, 933.4539294512718, 660.6234446365573, 677.0724107972061, 690.6305126757161, 693.5769180799708, 696.1680791454214, 15163.848361516353, 15176.696466070616, 15184.392624295126, 15255.694886102216, 15291.923540382339, 12326.19879707825, 12393.194442361219, 12416.565420210249, 12564.937175314066, 12597.748045039049, 8456.40805143634, 9883.456409897453, 9952.651657191964, 10041.598336066621, 10341.121004714609, 3478.826058697055, 3519.5072689823446, 3539.292141571696, 3544.61009288978, 3554.0581745837376, 68933.0, 76534.85197722039, 81828.59085704593, 82472.76290855581, 83173.0, 9366.110219529133, 9367.250619950388, 9402.858957115648, 9472.431654100637, 9610.711678649652, 21759.45601359947, 21820.672689909665, 22090.88954555249, 22132.88933555322, 22134.003969821395, 6498.610083394917, 7379.372753316028, 7450.18048014718, 7528.058992625922, 7591.8861217080685, 3979.1047014421524, 4018.7186896916937, 4062.695297852673, 4067.9796601016806, 4079.3880917861966, 3522.806245656462, 3525.9294814104087, 3555.822208889545, 3569.214772749991, 3572.3212589607892, 606.8513214262534, 614.3181069013392, 659.1365311442026, 661.2428769059496, 662.5627086123136, 477.43900916423064, 573.2862586080356, 577.7804434315018, 582.7406803972276, 623.4389049855166, 8074.273315401642, 8082.838343233102, 8156.265936065783, 8182.590870456454, 8304.125101105357, 569.5130663282916, 579.547952596975, 599.409581562161, 614.1862032806549, 615.6983078291695, 3615.783053016775, 3643.2531331077066, 3771.8868433947027, 3822.5412950446125, 3850.2876967761053, 79443.80834287491, 79709.0, 81350.18649813427, 81441.59279203566, 81536.59231703804, 72814.90777638339, 73505.63247183729, 73742.63128684323, 73913.52172956511, 74393.0, 64005.0, 64206.35793642097, 65114.674426627564, 65535.0, 66028.66985665137, 7572.659230334758, 7575.318221360104, 7616.543007419573, 7668.6165691716305, 7835.451518393657, 45193.32210016787, 46321.0, 46693.53306466892, 46699.76650116728, 47203.0, 45678.77160614176, 58089.0, 59263.40736592579, 62127.06809397953, 63070.68464657831, 9767.60929562838, 9860.852087218555, 10969.616063438061, 11297.830532541853, 11366.318020918441, 11780.175387722777, 11938.22401543897, 12055.819162712742, 12194.451249693962, 12545.680255659632, 11070.5571777128, 11076.169287303323, 11411.0, 11443.970042696197, 11576.305421674726, 11085.556577736801, 11253.66239012831, 11360.204785664924, 11586.536538538365, 11890.643280701594, 10640.574377024832, 10926.56293748273, 11078.612248571262, 11194.944025279821, 11374.260673056226, 9180.540972951192, 9456.14894659484, 9590.136887680143, 9590.808183836423, 9765.121139097515, 7770.805729856799, 9203.0, 9272.768180795534, 9383.483908384831, 9443.905560944302], "unit": "score", "name": "yui.html", "value": 6731.441016343368}], "name": "dromaeo_css", "value": 7401.929346737452}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 113.0, 114.0, 116.0, 123.0, 115.0, 116.0, 115.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [158.0, 123.0, 154.0, 193.0, 124.0, 144.0, 140.0, 122.0, 159.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [192.0, 224.0, 276.0, 230.0, 206.0, 198.0, 196.0, 196.0, 198.0, 187.0], "unit": "score", "name": "audio-dft", "value": 210.3}, {"lowerIsBetter": true, "replicates": [70.0, 76.0, 71.0, 115.0, 63.0, 77.0, 83.0, 87.0, 139.0, 57.0], "unit": "score", "name": "audio-fft", "value": 83.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 119.0, 79.0, 78.0, 81.0, 119.0, 79.0, 80.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [94.0, 87.0, 88.0, 132.0, 135.0, 85.0, 90.0, 85.0, 100.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.2}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 95.0, 99.0, 95.0, 94.0, 95.0, 95.0, 94.0, 132.0], "unit": "score", "name": "imaging-darkroom", "value": 98.7}, {"lowerIsBetter": true, "replicates": [151.0, 94.0, 94.0, 92.0, 92.0, 96.0, 90.0, 92.0, 116.0, 137.0], "unit": "score", "name": "imaging-desaturate", "value": 105.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 53.0, 61.0, 63.0, 83.0, 61.0, 88.0, 84.0], "unit": "score", "name": "json-parse-financial", "value": 65.7}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 74.0, 72.0, 67.0, 69.0, 84.0, 100.0, 100.0, 62.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.4}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 86.0, 83.0, 83.0, 85.0, 85.0, 84.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [132.0, 136.0, 145.0, 135.0, 132.0, 139.0, 121.0, 134.0, 146.0, 144.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 136.4}, {"lowerIsBetter": true, "replicates": [143.0, 142.0, 144.0, 130.0, 173.0, 188.0, 136.0, 138.0, 140.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 68.0, 72.0, 99.0, 100.0, 92.0, 72.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.4}], "name": "kraken", "value": 1538.6000000000006}]} 14:39:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1538.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7401.93"}}} 14:39:36 INFO - Return code: 0 14:39:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:39:36 ERROR - # TBPL SUCCESS # 14:39:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:39:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:39:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:39:36 INFO - 2016-03-02 14:39:36.539 screenresolution[1972:15074] starting screenresolution argv=screenresolution get 14:39:36 INFO - 2016-03-02 14:39:36.542 screenresolution[1972:15074] Display 0: 1600x1200x32@60 14:39:36 INFO - 2016-03-02 14:39:36.548 screenresolution[1973:15077] starting screenresolution argv=screenresolution list 14:39:36 INFO - Available Modes on Display 0 14:39:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:39:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:39:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:39:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:39:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:39:36 INFO - Intel Iris: 14:39:36 INFO - Chipset Model: Intel Iris 14:39:36 INFO - Type: GPU 14:39:36 INFO - Bus: Built-In 14:39:36 INFO - VRAM (Dynamic, Max): 1536 MB 14:39:36 INFO - Vendor: Intel (0x8086) 14:39:36 INFO - Device ID: 0x0a2e 14:39:36 INFO - Revision ID: 0x0009 14:39:36 INFO - Displays: 14:39:36 INFO - Display: 14:39:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:39:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:39:36 INFO - Display Serial Number: 1600x1200 60 14:39:36 INFO - Main Display: Yes 14:39:36 INFO - Mirror: Off 14:39:36 INFO - Online: Yes 14:39:36 INFO - Rotation: Supported 14:39:36 INFO - Return code: 0 14:39:36 INFO - Running post-action listener: _resource_record_post_action 14:39:36 INFO - Running post-run listener: _resource_record_post_run 14:39:37 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 2506752; Write bytes: 705427968; Read time: 46; Write time: 1960 14:39:37 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 388104704; Write bytes: 382056448; Read time: 28583; Write time: 632 14:39:37 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 2506752; Write bytes: 299617280; Read time: 46; Write time: 1178 14:39:37 INFO - Running post-run listener: _upload_blobber_files 14:39:37 INFO - Blob upload gear active. 14:39:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:39:37 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 14:39:37 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'] 14:39:37 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 14:39:38 INFO - (blobuploader) - INFO - Open directory for files ... 14:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:39 INFO - (blobuploader) - INFO - Done attempting. 14:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:40 INFO - (blobuploader) - INFO - Done attempting. 14:39:40 INFO - (blobuploader) - INFO - Iteration through files over. 14:39:40 INFO - Return code: 0 14:39:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:39:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:39:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/274c567a2b324b2c4efae770f21ec76fce6329ae3b06c8141b22e2589acc50d84cd4bf0bd3d02a33c95f215af7903b136fa058f1731bfa109b9f91b92f90b52c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa16658b7786f94d95820bd511f51675cb463097b88d08d711ca05662ac95fb3b5a1b8ea2daff5cd08b102d48502df9a231f42b162015ad06aa2d48773216bc"} 14:39:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:39:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:39:40 INFO - Contents: 14:39:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/274c567a2b324b2c4efae770f21ec76fce6329ae3b06c8141b22e2589acc50d84cd4bf0bd3d02a33c95f215af7903b136fa058f1731bfa109b9f91b92f90b52c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa16658b7786f94d95820bd511f51675cb463097b88d08d711ca05662ac95fb3b5a1b8ea2daff5cd08b102d48502df9a231f42b162015ad06aa2d48773216bc"} 14:39:40 INFO - Running post-run listener: copy_logs_to_upload_dir 14:39:40 INFO - Copying logs to upload dir... 14:39:40 INFO - mkdir: /builds/slave/test/build/upload/logs 14:39:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.358335 ========= master_lag: 0.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-02 14:39:41.044185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-02 14:39:41.049340) ========= 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.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/274c567a2b324b2c4efae770f21ec76fce6329ae3b06c8141b22e2589acc50d84cd4bf0bd3d02a33c95f215af7903b136fa058f1731bfa109b9f91b92f90b52c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa16658b7786f94d95820bd511f51675cb463097b88d08d711ca05662ac95fb3b5a1b8ea2daff5cd08b102d48502df9a231f42b162015ad06aa2d48773216bc"} build_url:https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010393 build_url: 'https://queue.taskcluster.net/v1/task/NN2pBl7pQoeKjH742bfk2A/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/274c567a2b324b2c4efae770f21ec76fce6329ae3b06c8141b22e2589acc50d84cd4bf0bd3d02a33c95f215af7903b136fa058f1731bfa109b9f91b92f90b52c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa16658b7786f94d95820bd511f51675cb463097b88d08d711ca05662ac95fb3b5a1b8ea2daff5cd08b102d48502df9a231f42b162015ad06aa2d48773216bc"}' ========= master_lag: 4.46 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-02 14:39:45.517555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:39:45.517865) ========= 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.bmWeyj1Duc/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.21YarR7erH/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005211 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 14:39:45.562558) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-02 14:39:45.562829) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-02 14:39:49.110197) ========= ========= Total master_lag: 5.32 =========