builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0089 starttime: 1455798620.69 results: success (0) buildid: 20160218024627 builduid: a7adc202ea5a4a748910bd7cc0550ae2 revision: 1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.691318) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.691825) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.692188) ========= 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.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005552 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.714517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.714827) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.730061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.730489) ========= 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.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005244 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.780914) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.781249) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.781663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.781972) ========= 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.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-18 04:30:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2016-02-18 04:30:20 (143 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.963494) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:20.963872) ========= 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.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.018740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:21.015513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:21.016265) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e --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 1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-18 04:30:21,086 truncating revision to first 12 chars 2016-02-18 04:30:21,086 Setting DEBUG logging. 2016-02-18 04:30:21,086 attempt 1/10 2016-02-18 04:30:21,086 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ce1ca5182e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 04:30:21,705 unpacking tar archive at: fx-team-1ce1ca5182e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.855818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:21.892755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:21.893156) ========= echo 1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e program finished with exit code 0 elapsedTime=0.005100 script_repo_revision: '1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:21.943206) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:21.943564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 04:30:21.956951) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-18 04:30:21.957264) ========= /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.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:30:22 INFO - MultiFileLogger online at 20160218 04:30:22 in /builds/slave/test 04:30:22 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 04:30:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:22 INFO - {'append_to_log': False, 04:30:22 INFO - 'base_work_dir': '/builds/slave/test', 04:30:22 INFO - 'blob_upload_branch': 'Fx-Team', 04:30:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:22 INFO - 'branch': 'Fx-Team', 04:30:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:22 INFO - 'config_files': ('talos/mac_config.py',), 04:30:22 INFO - 'default_actions': ('clobber', 04:30:22 INFO - 'read-buildbot-config', 04:30:22 INFO - 'download-and-extract', 04:30:22 INFO - 'populate-webroot', 04:30:22 INFO - 'create-virtualenv', 04:30:22 INFO - 'install', 04:30:22 INFO - 'run-tests'), 04:30:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:22 INFO - 'download_minidump_stackwalk': True, 04:30:22 INFO - 'download_symbols': 'ondemand', 04:30:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:22 INFO - 'installer_path': 'installer.exe', 04:30:22 INFO - 'log_level': 'info', 04:30:22 INFO - 'log_name': 'talos', 04:30:22 INFO - 'log_to_console': True, 04:30:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:30:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:30:22 INFO - 'opt_config_files': (), 04:30:22 INFO - 'pip_index': False, 04:30:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:22 INFO - 'cmd': ('bash', 04:30:22 INFO - '-c', 04:30:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:22 INFO - 'enabled': True, 04:30:22 INFO - 'halt_on_failure': False, 04:30:22 INFO - 'name': 'check_screen_resolution'},), 04:30:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:22 INFO - 'cmd': ('bash', 04:30:22 INFO - '-c', 04:30:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:22 INFO - 'enabled': True, 04:30:22 INFO - 'halt_on_failure': False, 04:30:22 INFO - 'name': 'check_screen_resolution'},), 04:30:22 INFO - 'run_cmd_checks_enabled': True, 04:30:22 INFO - 'sps_profile': False, 04:30:22 INFO - 'sps_profile_interval': 0, 04:30:22 INFO - 'suite': 'dromaeojs-e10s', 04:30:22 INFO - 'system_bits': '32', 04:30:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:22 INFO - 'title': 't-yosemite-r7-0089', 04:30:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:22 INFO - 'use_talos_json': True, 04:30:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:22 INFO - 'work_dir': 'build'} 04:30:22 INFO - ##### 04:30:22 INFO - ##### Running clobber step. 04:30:22 INFO - ##### 04:30:22 INFO - Running pre-action listener: _resource_record_pre_action 04:30:22 INFO - Running main action method: clobber 04:30:22 INFO - rmtree: /builds/slave/test/build 04:30:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:22 INFO - Running post-action listener: _resource_record_post_action 04:30:22 INFO - ##### 04:30:22 INFO - ##### Running read-buildbot-config step. 04:30:22 INFO - ##### 04:30:22 INFO - Running pre-action listener: _resource_record_pre_action 04:30:22 INFO - Running main action method: read_buildbot_config 04:30:22 INFO - Using buildbot properties: 04:30:22 INFO - { 04:30:22 INFO - "project": "", 04:30:22 INFO - "product": "firefox", 04:30:22 INFO - "script_repo_revision": "production", 04:30:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:30:22 INFO - "repository": "", 04:30:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:30:22 INFO - "buildid": "20160218024627", 04:30:22 INFO - "pgo_build": "False", 04:30:22 INFO - "basedir": "/builds/slave/test", 04:30:22 INFO - "buildnumber": 453, 04:30:22 INFO - "slavename": "t-yosemite-r7-0089", 04:30:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:30:22 INFO - "platform": "yosemite_r7", 04:30:22 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:30:22 INFO - "branch": "fx-team", 04:30:22 INFO - "repo_path": "integration/fx-team", 04:30:22 INFO - "revision": "1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e", 04:30:22 INFO - "stage_platform": "macosx64", 04:30:22 INFO - "builduid": "a7adc202ea5a4a748910bd7cc0550ae2", 04:30:22 INFO - "slavebuilddir": "test" 04:30:22 INFO - } 04:30:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:30:22 INFO - Running post-action listener: _resource_record_post_action 04:30:22 INFO - ##### 04:30:22 INFO - ##### Running download-and-extract step. 04:30:22 INFO - ##### 04:30:22 INFO - Running pre-action listener: _resource_record_pre_action 04:30:22 INFO - Running main action method: download_and_extract 04:30:22 INFO - mkdir: /builds/slave/test/build/tests 04:30:22 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')]} 04:30:22 INFO - https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:30:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/test_packages.json 04:30:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/test_packages.json 04:30:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:30:23 INFO - Downloaded 1277 bytes. 04:30:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:30:23 INFO - Using the following test package requirements: 04:30:23 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:30:23 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:23 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:30:23 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:23 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:30:23 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:23 INFO - u'jsshell-mac.zip'], 04:30:23 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:23 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:30:23 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:30:23 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:23 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:30:23 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:23 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:30:23 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:23 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:30:23 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:30:23 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:23 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:30:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:30: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')]} 04:30:23 INFO - https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/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 04:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/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 04:30:24 INFO - Downloaded 17806578 bytes. 04:30:24 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'] 04:30:24 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 04:30:27 INFO - Return code: 0 04:30:27 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 04:30: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')]} 04:30:27 INFO - https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/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 04:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/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 04:30:29 INFO - Downloaded 17806578 bytes. 04:30:29 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'] 04:30:29 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 04:30:32 INFO - Return code: 0 04:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:32 INFO - https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/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 04:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/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 04:30:33 INFO - Downloaded 10707071 bytes. 04:30:33 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'] 04:30:33 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 04:30:33 INFO - Return code: 0 04:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:33 INFO - https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b59Y5R1RRNyIQdjIGpJX8A/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 04:30:36 INFO - Downloaded 111228847 bytes. 04:30:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:30:36 INFO - mkdir: /builds/slave/test/properties 04:30:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:36 INFO - Contents: 04:30:36 INFO - build_url:https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:30:38 INFO - Running post-action listener: _resource_record_post_action 04:30:38 INFO - Running post-action listener: set_extra_try_arguments 04:30:38 INFO - ##### 04:30:38 INFO - ##### Running populate-webroot step. 04:30:38 INFO - ##### 04:30:38 INFO - Running pre-action listener: _resource_record_pre_action 04:30:38 INFO - Running main action method: populate_webroot 04:30:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:38 INFO - '--tppagecycles', 04:30:38 INFO - '7'], 04:30:38 INFO - 'tests': ['tsvgm']}}, 04:30:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:30:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:30:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:38 INFO - 'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:38 INFO - 'tests': ['damp', 'tps']}, 04:30:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:38 INFO - 'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['damp', 'tps']}, 04:30:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:30:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:38 INFO - 'other': {'tests': ['a11yr', 04:30:38 INFO - 'ts_paint', 04:30:38 INFO - 'tpaint', 04:30:38 INFO - 'sessionrestore', 04:30:38 INFO - 'sessionrestore_no_auto_restore']}, 04:30:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['a11yr', 04:30:38 INFO - 'ts_paint', 04:30:38 INFO - 'tpaint', 04:30:38 INFO - 'sessionrestore', 04:30:38 INFO - 'sessionrestore_no_auto_restore']}, 04:30:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['a11yr', 04:30:38 INFO - 'ts_paint', 04:30:38 INFO - 'tpaint', 04:30:38 INFO - 'sessionrestore', 04:30:38 INFO - 'sessionrestore_no_auto_restore']}, 04:30:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['a11yr', 04:30:38 INFO - 'ts_paint', 04:30:38 INFO - 'tpaint', 04:30:38 INFO - 'sessionrestore', 04:30:38 INFO - 'sessionrestore_no_auto_restore']}, 04:30:38 INFO - 'other_l64': {'tests': ['a11yr', 04:30:38 INFO - 'ts_paint', 04:30:38 INFO - 'tpaint', 04:30:38 INFO - 'sessionrestore', 04:30:38 INFO - 'sessionrestore_no_auto_restore']}, 04:30:38 INFO - 'other_nol64': {'tests': ['a11yr', 04:30:38 INFO - 'ts_paint', 04:30:38 INFO - 'tpaint', 04:30:38 INFO - 'sessionrestore', 04:30:38 INFO - 'sessionrestore_no_auto_restore']}, 04:30:38 INFO - 'svgr': {'tests': ['tsvgx', 04:30:38 INFO - 'tsvgr_opacity', 04:30:38 INFO - 'tart', 04:30:38 INFO - 'tscrollx', 04:30:38 INFO - 'cart']}, 04:30:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['tsvgx', 04:30:38 INFO - 'tsvgr_opacity', 04:30:38 INFO - 'tart', 04:30:38 INFO - 'tscrollx', 04:30:38 INFO - 'cart']}, 04:30:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:38 INFO - 'tests': ['tp5o']}, 04:30:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:38 INFO - 'talos_options': ['--e10s'], 04:30:38 INFO - 'tests': ['tp5o']}, 04:30:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:38 INFO - 'talos_options': ['--xperf_path', 04:30:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:38 INFO - 'tests': ['tp5n']}, 04:30:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:38 INFO - 'talos_options': ['--e10s', 04:30:38 INFO - '--xperf_path', 04:30:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:38 INFO - 'tests': ['tp5n']}}, 04:30:38 INFO - 'talos.zip': {'path': '', 04:30:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:38 INFO - Running post-action listener: _resource_record_post_action 04:30:38 INFO - ##### 04:30:38 INFO - ##### Running create-virtualenv step. 04:30:38 INFO - ##### 04:30:38 INFO - Running pre-action listener: _resource_record_pre_action 04:30:38 INFO - Running main action method: create_virtualenv 04:30:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:38 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 04:30:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:38 INFO - Using real prefix '/tools/python27' 04:30:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:41 INFO - Installing pip.................done. 04:30:41 INFO - Return code: 0 04:30:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30:41 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')]} 04:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:41 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')]} 04:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:41 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 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:30:41 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 04:30:41 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 04:30:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:30:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:41 INFO - 'HOME': '/Users/cltbld', 04:30:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:41 INFO - 'LOGNAME': 'cltbld', 04:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:41 INFO - 'MOZ_NO_REMOTE': '1', 04:30:41 INFO - 'NO_EM_RESTART': '1', 04:30:41 INFO - 'PAGER': '/bin/cat', 04:30:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:41 INFO - 'PWD': '/builds/slave/test', 04:30:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:41 INFO - 'SHELL': '/bin/bash', 04:30:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:30:41 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:30:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:41 INFO - 'USER': 'cltbld', 04:30:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:41 INFO - 'XPC_FLAGS': '0x0', 04:30:41 INFO - 'XPC_SERVICE_NAME': '0', 04:30:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:41 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 04:30:41 INFO - Cleaning up... 04:30:41 INFO - Return code: 0 04:30:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:30:41 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')]} 04:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:41 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')]} 04:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:41 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 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:30:41 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 04:30:41 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 04:30:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:30:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:41 INFO - 'HOME': '/Users/cltbld', 04:30:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:41 INFO - 'LOGNAME': 'cltbld', 04:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:41 INFO - 'MOZ_NO_REMOTE': '1', 04:30:41 INFO - 'NO_EM_RESTART': '1', 04:30:41 INFO - 'PAGER': '/bin/cat', 04:30:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:41 INFO - 'PWD': '/builds/slave/test', 04:30:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:41 INFO - 'SHELL': '/bin/bash', 04:30:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:30:41 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:30:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:41 INFO - 'USER': 'cltbld', 04:30:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:41 INFO - 'XPC_FLAGS': '0x0', 04:30:41 INFO - 'XPC_SERVICE_NAME': '0', 04:30:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:42 INFO - Downloading/unpacking psutil>=0.7.1 04:30:42 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 04:30:42 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 04:30:42 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 04:30:42 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 04:30:42 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 04:30:42 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 04:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:45 INFO - Installing collected packages: psutil 04:30:45 INFO - Running setup.py install for psutil 04:30:45 INFO - building 'psutil._psutil_osx' extension 04:30:45 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 04:30:45 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 04:30:45 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 04:30:45 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 04:30:45 INFO - building 'psutil._psutil_posix' extension 04:30:45 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 04:30:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:30:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:30:45 INFO - ^ 04:30:45 INFO - 1 warning generated. 04:30:45 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 04:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:45 INFO - Successfully installed psutil 04:30:45 INFO - Cleaning up... 04:30:45 INFO - Return code: 0 04:30:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:30:45 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')]} 04:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:45 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')]} 04:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:45 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 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:30:45 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 04:30:45 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 04:30:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:30:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:45 INFO - 'HOME': '/Users/cltbld', 04:30:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:45 INFO - 'LOGNAME': 'cltbld', 04:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:45 INFO - 'MOZ_NO_REMOTE': '1', 04:30:45 INFO - 'NO_EM_RESTART': '1', 04:30:45 INFO - 'PAGER': '/bin/cat', 04:30:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:45 INFO - 'PWD': '/builds/slave/test', 04:30:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:45 INFO - 'SHELL': '/bin/bash', 04:30:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:30:45 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:30:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:45 INFO - 'USER': 'cltbld', 04:30:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:45 INFO - 'XPC_FLAGS': '0x0', 04:30:45 INFO - 'XPC_SERVICE_NAME': '0', 04:30:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:30:46 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 04:30:46 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 04:30:46 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 04:30:46 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 04:30:46 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 04:30:46 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 04:30:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:30:48 INFO - Installing collected packages: mozsystemmonitor 04:30:48 INFO - Running setup.py install for mozsystemmonitor 04:30:48 INFO - Successfully installed mozsystemmonitor 04:30:48 INFO - Cleaning up... 04:30:48 INFO - Return code: 0 04:30:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:30:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:30:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:48 INFO - 'HOME': '/Users/cltbld', 04:30:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:48 INFO - 'LOGNAME': 'cltbld', 04:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:48 INFO - 'MOZ_NO_REMOTE': '1', 04:30:48 INFO - 'NO_EM_RESTART': '1', 04:30:48 INFO - 'PAGER': '/bin/cat', 04:30:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:48 INFO - 'PWD': '/builds/slave/test', 04:30:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:48 INFO - 'SHELL': '/bin/bash', 04:30:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:30:48 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:30:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:48 INFO - 'USER': 'cltbld', 04:30:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:48 INFO - 'XPC_FLAGS': '0x0', 04:30:48 INFO - 'XPC_SERVICE_NAME': '0', 04:30:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 INFO - Downloading docopt-0.6.1.tar.gz 04:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:52 INFO - Running setup.py install for blobuploader 04:30:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:52 INFO - Running setup.py install for requests 04:30:53 INFO - Running setup.py install for docopt 04:30:53 INFO - Successfully installed blobuploader requests docopt 04:30:53 INFO - Cleaning up... 04:30:53 INFO - Return code: 0 04:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:53 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 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:30:53 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 04:30:53 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 04:30:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:30:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:53 INFO - 'HOME': '/Users/cltbld', 04:30:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:53 INFO - 'LOGNAME': 'cltbld', 04:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:53 INFO - 'MOZ_NO_REMOTE': '1', 04:30:53 INFO - 'NO_EM_RESTART': '1', 04:30:53 INFO - 'PAGER': '/bin/cat', 04:30:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:53 INFO - 'PWD': '/builds/slave/test', 04:30:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:53 INFO - 'SHELL': '/bin/bash', 04:30:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:30:53 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:30:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:53 INFO - 'USER': 'cltbld', 04:30:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:53 INFO - 'XPC_FLAGS': '0x0', 04:30:53 INFO - 'XPC_SERVICE_NAME': '0', 04:30:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-HtNOea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-kwzOic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-MskGUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-z60AAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-xNLCEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-jQg1Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-3M3gaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-reX9jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-s8U1TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-LnmtYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:54 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-fpT3r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-gX8jNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-fwAvva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-oCh_db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-bUsu81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-lZDD62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:55 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-UZaL6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:55 INFO - Running setup.py install for manifestparser 04:30:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:55 INFO - Running setup.py install for mozcrash 04:30:56 INFO - Running setup.py install for mozdebug 04:30:56 INFO - Running setup.py install for mozdevice 04:30:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozfile 04:30:56 INFO - Running setup.py install for mozhttpd 04:30:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozinfo 04:30:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozInstall 04:30:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozleak 04:30:57 INFO - Running setup.py install for mozlog 04:30:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for moznetwork 04:30:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozprocess 04:30:57 INFO - Running setup.py install for mozprofile 04:30:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozrunner 04:30:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozscreenshot 04:30:57 INFO - Running setup.py install for moztest 04:30:58 INFO - Running setup.py install for mozversion 04:30:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:58 INFO - Cleaning up... 04:30:58 INFO - Return code: 0 04:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:30:58 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 04:30:58 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 04:30:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:30:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:58 INFO - 'HOME': '/Users/cltbld', 04:30:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:58 INFO - 'LOGNAME': 'cltbld', 04:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:58 INFO - 'MOZ_NO_REMOTE': '1', 04:30:58 INFO - 'NO_EM_RESTART': '1', 04:30:58 INFO - 'PAGER': '/bin/cat', 04:30:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:58 INFO - 'PWD': '/builds/slave/test', 04:30:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:58 INFO - 'SHELL': '/bin/bash', 04:30:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:30:58 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:30:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:58 INFO - 'USER': 'cltbld', 04:30:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:58 INFO - 'XPC_FLAGS': '0x0', 04:30:58 INFO - 'XPC_SERVICE_NAME': '0', 04:30:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-RJCHDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-6ZODel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-G_QVWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-ZdGUP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-lgG_x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-kjImCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-RFl6Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Or6V8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-qIowuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-8KrCBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-0NL26Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-eBIewQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-NGWfN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:59 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-V9H2Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:00 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-oO7brF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:00 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-C3TBfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:00 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-FHF83J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:00 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)) 04:31:00 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)) 04:31:00 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)) 04:31:00 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)) 04:31:00 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)) 04:31:00 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)) 04:31:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:02 INFO - Downloading blessings-1.6.tar.gz 04:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:02 INFO - Installing collected packages: blessings 04:31:02 INFO - Running setup.py install for blessings 04:31:02 INFO - Successfully installed blessings 04:31:02 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:03 INFO - Reading from file tmpfile_stdout 04:31:03 INFO - Current package versions: 04:31:03 INFO - blessings == 1.6 04:31:03 INFO - blobuploader == 1.2.4 04:31:03 INFO - docopt == 0.6.1 04:31:03 INFO - manifestparser == 1.1 04:31:03 INFO - mozInstall == 1.12 04:31:03 INFO - mozcrash == 0.16 04:31:03 INFO - mozdebug == 0.1 04:31:03 INFO - mozdevice == 0.48 04:31:03 INFO - mozfile == 1.2 04:31:03 INFO - mozhttpd == 0.7 04:31:03 INFO - mozinfo == 0.9 04:31:03 INFO - mozleak == 0.1 04:31:03 INFO - mozlog == 3.1 04:31:03 INFO - moznetwork == 0.27 04:31:03 INFO - mozprocess == 0.22 04:31:03 INFO - mozprofile == 0.28 04:31:03 INFO - mozrunner == 6.11 04:31:03 INFO - mozscreenshot == 0.1 04:31:03 INFO - mozsystemmonitor == 0.0 04:31:03 INFO - moztest == 0.7 04:31:03 INFO - mozversion == 1.4 04:31:03 INFO - psutil == 3.1.1 04:31:03 INFO - requests == 1.2.3 04:31:03 INFO - wsgiref == 0.1.2 04:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:31:03 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 04:31:03 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 04:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:03 INFO - 'HOME': '/Users/cltbld', 04:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:03 INFO - 'LOGNAME': 'cltbld', 04:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:03 INFO - 'MOZ_NO_REMOTE': '1', 04:31:03 INFO - 'NO_EM_RESTART': '1', 04:31:03 INFO - 'PAGER': '/bin/cat', 04:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:03 INFO - 'PWD': '/builds/slave/test', 04:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:03 INFO - 'SHELL': '/bin/bash', 04:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:31:03 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:03 INFO - 'USER': 'cltbld', 04:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:03 INFO - 'XPC_FLAGS': '0x0', 04:31:03 INFO - 'XPC_SERVICE_NAME': '0', 04:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:31:03 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 04:31:03 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 04:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:03 INFO - 'HOME': '/Users/cltbld', 04:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:03 INFO - 'LOGNAME': 'cltbld', 04:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:03 INFO - 'MOZ_NO_REMOTE': '1', 04:31:03 INFO - 'NO_EM_RESTART': '1', 04:31:03 INFO - 'PAGER': '/bin/cat', 04:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:03 INFO - 'PWD': '/builds/slave/test', 04:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:03 INFO - 'SHELL': '/bin/bash', 04:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:31:03 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:03 INFO - 'USER': 'cltbld', 04:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:03 INFO - 'XPC_FLAGS': '0x0', 04:31:03 INFO - 'XPC_SERVICE_NAME': '0', 04:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:03 INFO - Downloading/unpacking jsonschema 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:06 INFO - Downloading/unpacking functools32 (from jsonschema) 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:06 INFO - warning: no files found matching '*.txt' 04:31:06 INFO - no previously-included directories found matching 'build' 04:31:06 INFO - no previously-included directories found matching 'dist' 04:31:06 INFO - no previously-included directories found matching '.git*' 04:31:06 INFO - Installing collected packages: jsonschema, functools32 04:31:06 INFO - Running setup.py install for functools32 04:31:06 INFO - warning: no files found matching '*.txt' 04:31:06 INFO - no previously-included directories found matching 'build' 04:31:06 INFO - no previously-included directories found matching 'dist' 04:31:06 INFO - no previously-included directories found matching '.git*' 04:31:06 INFO - Successfully installed jsonschema functools32 04:31:06 INFO - Cleaning up... 04:31:06 INFO - Return code: 0 04:31:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ae6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae714c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b955ae80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, '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.D27sTTJmuh/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.gEDesf1AbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 04:31: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', 'flake8'] in /builds/slave/test/build 04:31: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 flake8 04:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:06 INFO - 'HOME': '/Users/cltbld', 04:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:06 INFO - 'LOGNAME': 'cltbld', 04:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:06 INFO - 'MOZ_NO_REMOTE': '1', 04:31:06 INFO - 'NO_EM_RESTART': '1', 04:31:06 INFO - 'PAGER': '/bin/cat', 04:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:06 INFO - 'PWD': '/builds/slave/test', 04:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:06 INFO - 'SHELL': '/bin/bash', 04:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:31:06 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:06 INFO - 'USER': 'cltbld', 04:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:06 INFO - 'XPC_FLAGS': '0x0', 04:31:06 INFO - 'XPC_SERVICE_NAME': '0', 04:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:07 INFO - Downloading/unpacking flake8 04:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:31:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:31:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:31:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:10 INFO - no previously-included directories found matching 'docs/_build' 04:31:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:31:10 INFO - Running setup.py install for pep8 04:31:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:10 INFO - no previously-included directories found matching 'docs/_build' 04:31:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:31:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:31:10 INFO - Cleaning up... 04:31:11 INFO - Return code: 0 04:31:11 INFO - Running post-action listener: _resource_record_post_action 04:31:11 INFO - Running post-action listener: _start_resource_monitoring 04:31:11 INFO - Starting resource monitoring. 04:31:11 INFO - ##### 04:31:11 INFO - ##### Running install step. 04:31:11 INFO - ##### 04:31:11 INFO - Running pre-action listener: _resource_record_pre_action 04:31:11 INFO - Running main action method: install 04:31:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:11 INFO - Reading from file tmpfile_stdout 04:31:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:11 INFO - Reading from file tmpfile_stdout 04:31:11 INFO - Output received: 04:31:11 INFO - Usage: mozinstall [options] installer 04:31:11 INFO - Options: 04:31:11 INFO - -h, --help show this help message and exit 04:31:11 INFO - -d DEST, --destination=DEST 04:31:11 INFO - Directory to install application into. [default: 04:31:11 INFO - "/builds/slave/test"] 04:31:11 INFO - --app=APP Application being installed. [default: firefox] 04:31:11 INFO - mkdir: /builds/slave/test/build/application 04:31:11 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'] 04:31:11 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 04:31:45 INFO - Reading from file tmpfile_stdout 04:31:45 INFO - Output received: 04:31:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:31:45 INFO - Running post-action listener: _resource_record_post_action 04:31:45 INFO - ##### 04:31:45 INFO - ##### Running run-tests step. 04:31:45 INFO - ##### 04:31:45 INFO - Running pre-action listener: _resource_record_pre_action 04:31:45 INFO - Running main action method: run_tests 04:31:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:31:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:31:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:31:45 INFO - 2016-02-18 04:31:45.326 screenresolution[1937:9645] starting screenresolution argv=screenresolution get 04:31:45 INFO - 2016-02-18 04:31:45.329 screenresolution[1937:9645] Display 0: 1600x1200x32@60 04:31:45 INFO - 2016-02-18 04:31:45.334 screenresolution[1938:9649] starting screenresolution argv=screenresolution list 04:31:45 INFO - Available Modes on Display 0 04:31:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:31:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:31:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:31:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:31:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:31:45 INFO - Intel Iris: 04:31:45 INFO - Chipset Model: Intel Iris 04:31:45 INFO - Type: GPU 04:31:45 INFO - Bus: Built-In 04:31:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:31:45 INFO - Vendor: Intel (0x8086) 04:31:45 INFO - Device ID: 0x0a2e 04:31:45 INFO - Revision ID: 0x0009 04:31:45 INFO - Displays: 04:31:45 INFO - Display: 04:31:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:31:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:31:45 INFO - Display Serial Number: 1600x1200 60 04:31:45 INFO - Main Display: Yes 04:31:45 INFO - Mirror: Off 04:31:45 INFO - Online: Yes 04:31:45 INFO - Rotation: Supported 04:31:45 INFO - Return code: 0 04:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:45 INFO - Python 2.7.3 04:31:45 INFO - Return code: 0 04:31:45 INFO - grabbing minidump binary from tooltool 04:31:45 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')]} 04:31:45 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 0x10ad0ed30>, '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 0x10ab32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad05b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:45 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 04:31:45 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 04:31:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:45 INFO - Return code: 0 04:31:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:31:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:31:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:31:46 INFO - Return code: 0 04:31:46 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/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--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 04:31:46 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/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0089 --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 04:31:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D27sTTJmuh/Render', 04:31:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:46 INFO - 'HOME': '/Users/cltbld', 04:31:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:46 INFO - 'LOGNAME': 'cltbld', 04:31:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:46 INFO - 'MOZ_NO_REMOTE': '1', 04:31:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:46 INFO - 'NO_EM_RESTART': '1', 04:31:46 INFO - 'PAGER': '/bin/cat', 04:31:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:46 INFO - 'PWD': '/builds/slave/test', 04:31:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:46 INFO - 'SHELL': '/bin/bash', 04:31:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gEDesf1AbK/Listeners', 04:31:46 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 04:31:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:46 INFO - 'USER': 'cltbld', 04:31:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:46 INFO - 'XPC_FLAGS': '0x0', 04:31:46 INFO - 'XPC_SERVICE_NAME': '0', 04:31:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:46 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/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--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 04:31:47 INFO - mozversion application_buildid: 20160218024627 04:31:47 INFO - mozversion application_changeset: 1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e 04:31:47 INFO - mozversion application_display_name: Nightly 04:31:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:47 INFO - mozversion application_name: Firefox 04:31:47 INFO - mozversion application_remotingname: firefox 04:31:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:31:47 INFO - mozversion application_vendor: Mozilla 04:31:47 INFO - mozversion application_version: 47.0a1 04:31:47 INFO - mozversion platform_buildid: 20160218024627 04:31:47 INFO - mozversion platform_changeset: 1ce1ca5182e0dd9cd83b428d3d8bd1d0be4cd67e 04:31:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:31:47 INFO - mozversion platform_version: 47.0a1 04:31:47 INFO - using testdate: 1455798707 04:31:47 INFO - actual date: 1455798707 04:31:47 INFO - starting webserver on 'localhost:49460' 04:31:47 INFO - SUITE-START | Running 2 tests 04:31:47 INFO - TEST-START | dromaeo_css 04:31:47 INFO - operating with platform_type : mac_ 04:31:47 INFO - Initialising browser for dromaeo_css test... 04:31:47 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpUN8xm0/profile http://localhost:49460/getInfo.html) 04:31:50 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 04:31:50 INFO - PROCESS | 1956 | colorDepth:24 04:31:50 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 04:31:50 INFO - PROCESS | 1956 | __metrics 04:31:50 ERROR - PROCESS | 1956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 04:31:51 INFO - TEST-INFO | 1956: exit 0 04:31:51 INFO - Browser initialized. 04:31:51 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:51 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpUN8xm0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:03 INFO - PROCESS | 1960 | RSS: Main: 255770624 04:32:03 INFO - PROCESS | 1960 | 04:32:52 INFO - PROCESS | 1960 | 1455798772703 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] 04:35:03 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:49460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49460/tests/dromaeo/cssquery-ext.html) 04:35:04 INFO - PROCESS | 1960 | RSS: Main: 269234176 04:35:04 INFO - PROCESS | 1960 | 04:38:06 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:49460/tests/dromaeo/cssquery-ext.html (next: http://localhost:49460/tests/dromaeo/cssquery-jquery.html) 04:38:07 INFO - PROCESS | 1960 | RSS: Main: 281063424 04:38:07 INFO - PROCESS | 1960 | 04:41:09 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:49460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49460/tests/dromaeo/cssquery-mootools.html) 04:41:09 INFO - PROCESS | 1960 | RSS: Main: 283754496 04:41:09 INFO - PROCESS | 1960 | 04:44:11 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:49460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49460/tests/dromaeo/cssquery-prototype.html) 04:44:12 INFO - PROCESS | 1960 | RSS: Main: 284590080 04:44:12 INFO - PROCESS | 1960 | 04:47:14 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:49460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49460/tests/dromaeo/cssquery-yui.html) 04:47:15 INFO - PROCESS | 1960 | RSS: Main: 286306304 04:47:15 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:49460/tests/dromaeo/cssquery-yui.html (next: http://localhost:49460/tests/dromaeo/cssquery-dojo.html) 04:50:17 INFO - PROCESS | 1960 | RSS: Main: 289415168 04:50:17 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | __start_tp_report 04:50:17 INFO - PROCESS | 1960 | _x_x_mozilla_page_load 04:50:17 INFO - PROCESS | 1960 | _x_x_mozilla_page_load_details 04:50:17 INFO - PROCESS | 1960 | |i|pagename|runs| 04:50:17 INFO - PROCESS | 1960 | |0;dojo.html;3247.8538465769043;3503.632118627544;3544.308859772342;3572.714182865371;3579.874704385347;5751.252337196159;5800.883982320351;5807.245058142446;5809.651420914748;5830.3586605473365;5638.577106716992;5801.47786699197;5859.501942334907;5864.530837532998;5878.7648494060295;5210.452902445255;5249.580033597303;5279.736013199344;5313.840584782462;5323.707196104213;5179.818706345279;5244.318238628992;5340;5351.063563876325;5370.3287089113865;5144.305518754995;5156.510131537498;5246.396664383587;5250.684958902478;5272.9981303552395;5190.195519694454;5207.088759467116;5234.738263086831;5234.92147617786;5238.476152384731;5151.974240128776;5222.76497557607;5231.607629427808;5238.711870847102;5249.685018898878;4938.913439043405;5458.6724796512335;5536.667799932017;5706.572007099443;5737.225474560964;6297.842553936142;6303.779367722108;6305.0857625644485;6328.145700330442;6344.777932772331;6187.504999600066;6210.534209934273;6294.685265736694;6302.369763023661;6334;5840.386759390245;5870.119482077723;5870.295564532284;5876.236089308362;5879.882402351929;6301.369863013662;6314.778982735582;6320.494360451153;6339.714712837934;6343.841403964938;6079.148919151322;6142.7136481981925;6225.564210505312;6227.283862355796;6254.3745625438005;6260;6269.46709529686;6273.65494897785;6277.560570760094;6286.622802631857;4859.2954021666665;6068.6358818471035;6222.191115155001;6283.183186185766;6297.842553936188;6190.845228869314;6197.4732147767945;6247.250329960434;6277.748890044439;6281.654509001957;4864.124457597595;4946.802127914843;4962.379702537183;4964.255361695775;4978.228374601942;4343.652507799368;4367.192069467159;4467.352233926063;4467.486239082482;4484.573965473275;5837.88324233513;5943.405659434022;5955.404459554096;5959.761609535657;5966.045432730829;6273.592216505913;6280.591761535486;6285.59143655661;6290.056491526308;6336.20797400325;4894.412670479565;5715.485606295453;5882.941170588239;5896.734646940898;6014.278286605635;5364.249005139206;5380.300560927054;5396.379416367168;5410.945890541123;5432.158015507603;6255.874882502416;6331.113644089739;6413.422791948654;6431.967840160769;6501.674916254168;5743.942560574341;6262.405071518198;6267.749290028348;6279.529035322278;6295.937040629535;6025.307089684742;6416.32628573993;6422.2614399344675;6422.678866056772;6470.773522926675;5257.658252213594;6096.085587161784;6171.47542458896;6275.717592708431;6304.905426418699;6265.060240963892;6269.090981807703;6292.119103325446;6293.402126797947;6309;5000.199968005102;5897.410258974069;6141.4730411843775;6146.262448506208;6228.28374736893;6144.617461071223;6201.844953876189;6208.286047104641;6224.128621992834;6237.625742455467;5985.610935289366;6013.5877710061295;6050.183225264533;6065.211522502046;6126.908096378647;5990.820275391745;6053.697315134314;6125.754969801158;6188.226471691039;6225.688715564294;5975.970120149372;5986.401359864153;6020.849478762891;6035.728392222272;6059.424354686298 04:50:17 INFO - PROCESS | 1960 | |1;ext.html;447.50997657564955;452.6785981952813;460.86634875885994;482.39941273114977;535.9919601205982;37191.442128368064;37744;37838.621613783886;37854.621453785454;37916.620833791654;39157.804210978975;39503.81488555341;39649.60350396495;39717.40423893637;39797;8115.675372985088;9571.52142392881;9616;9673.226141908666;9681.467519286436;9440.905590944072;9624.56689448973;9649.807003859918;9657.22742180624;9735.610575576968;9702.417854928726;9714.07716266957;9728.17310528606;9755.853662195073;9784.07051330126;8243.134470880561;9722.708318750449;9743.902560974371;9746.31775775696;9774.364666296704;9607.13535781783;9733.805323893554;9757.170640495566;9782.364146330467;9806.803863922752;38271.42592861109;38374.80812595947;38561.65034223789;38685.419718704245;38875.22249554993;2700.5139074966496;2738.904138355148;2752.931176720578;3323.9695694334832;3529.8058606776617;28890.27774305638;29011.854940725374;29081.272968175752;29344.11967640974;29442.852785736148;2801.495730768461;2851.9144425667264;2854.4576530459144;2870.8851645934137;2997.385535965122;493184;499413;500279;500779;503828;41994;59699;61152;61873;63635.681821590595;56147.438525615034;60958;61361;61447.69276153591;61618.383816161266;15851.52445426616;16143.273552690158;16237.51287461378;16257.430989915296;16294.511164665078;12476.313802740937;12530.937345313216;12553;12553.811692824615;12565.560205392767;19146.617067658568;19715.605687886164;19932.800671993093;19969.9016554088;19977.900110499355;8521.744347669579;8740.115761798592;8812.647494100293;8832.293416526663;8851.380403371702;870.7474832298562;921.8386782313069;938.877945867033;941.9544305820534;1000.7398076500017;27513.862430687717;30001.399972000876;30445.543316850264;30498.085057448312;30619.693803061684;1023.2121266624806;1069.6095924987324;1070.5450183671908;1119.787240424333;1167.8948894599357;11869.881301186877;13888.652783680287;14047.508337208148;14219.85780142206;14220.431182752574;551854;556796;561007;562153;562760;55968.16047759287;56349.71825140848;56840;56865;56869.43130568724;1386.3068465767117;1394.4840409048718;1404.9277315959082;1418.7588110021115;1427.215031732543;26438.867805660848;27294.181174564794;27690.3077423058;27700.16899492938;27797.305067373476;47387;48309;48781.268280976525;48926;48942.7764305881;520498;524919;528595.3570232125;529146;529483;30432;32396.676033239364;33234;33249.83375083206;33346.16634584155;40164.1967160661;41090.58909410868;41254.38118428286;41698;42278.36582451204;28873.422531549673;34231.657683423844;35228;35378;35684.821575891954;34329.141771455914;34597;35007.299854003286;35022.82488587541;35060.47409288914;36293.455598166576;36602.8169859149;37083.443748343256;37114.25771484609;37117.25765484621;28108.016219432222;29844.403111938074;30894;31155.844220778752;32438.513422298212;23861.642075368538;24686.753132468446;24945.376365591004;25104.37239069038;25137.622935655614 04:50:17 INFO - PROCESS | 1960 | |2;jquery.html;306.62438512821797;359.35854499717993;359.88663570975143;366.7799320407756;368.5927050609075;15375.615609609766;15499.535013949571;18934.05329733513;19038.238470461165;20174.59650806983;13862.960277979168;15396.384144634201;15553.766693499578;18767;19630.509237269074;5091.210862316338;5343.946560534384;5345.3585569731495;5352.411234764173;5357.892842143155;5126.333576635032;5215.791368345262;5230.189320655286;5716.7141642917895;5882.970585147068;3902.2780785554764;5604.299462567179;5831.737571809279;5840.240768700063;5854.034084376073;5728.226689396941;5763.164341170507;5821.27234095738;5822.592418530705;5858.857522783059;5368.30212072432;5611.382747897728;5611.6352437091455;5623.662580245157;5626.887462250773;23502.412439688975;23527.41181470477;23911.16310929109;23984.28047158588;24011;2089.3314139475374;2136.9893150534303;2180.6728990651372;2348.4598542335357;2419.1774796569075;10073.24450666203;10087.798244035152;11107;12150.45322960469;14103.294835258195;1707.5218938697185;1718.9857983789625;1741.2599645150888;1782.3494424535081;1784.8393644572052;97070.51464742632;100513;100912;102170;103896.96103038949;9170.90829091714;10951.945240273748;11220.607278745205;11237.83143252852;11284.040856527123;13315.40080696371;13367.933160334136;13382.866171338357;13388.93305533466;13402.93298533501;8486.74539763808;8511.191436813493;8518.531480768617;8566.61450234741;8629.05080441151;8627.137286271323;8671.826563468696;8686.522241276663;8716.694915678048;8728.825423491495;4357.215701173755;4411.602955733999;4429.800658970354;4429.822807087745;4468.843590474317;1824.6715591193713;1876.6262518718813;1922.6154769046248;1924.7777661184969;1926.6724656808376;331.6169823853453;365.59784237339244;389.4080996884776;394.10538078561507;420.1890351621339;10441.164706823436;10950.452477376099;11642.600177384462;11727.179097463266;11785.057195424346;885.1369914333602;962.0764066496242;963.6386355116831;966.9419834809934;968.4698176880512;10368.585256589802;10708.1433485321;10739.731506712395;10760.838587421194;10808.621698240524;503521;511341;518234;802388;809908;78183.60908195423;124378;124412;126826;127030.09454858185;1057.619257067455;1162.314234601589;1174.3834486894277;1185.6206014075585;1188.9940550297192;15523.45667901618;17919.46241612754;18310.359137430125;18561.35035273759;19062.856228626326;37183.256334873695;50755.74622126866;51640.48359516507;52932;54228.457715422344;63291.683541581995;65099.67450162719;65837.67081164563;66247.66876165588;66301.66849165723;5778.566607504538;6424.839379015562;7552.9244707552225;7614.923850761643;7652.005239318853;9571.473568953774;12052.939735301268;12070.489421093853;12160.635180944586;12321.445534951128;10349.63776267827;10366.740831478972;10573.62992295266;10687.625933092304;10854.945725271324;8225.753227403187;10522.813499394302;10716.303440276357;10764.784704306026;10956.123510119012;10922.726931826768;11078.390688512209;11447.885521145015;11461.48423320936;11581;7656.846863062596;7846.019247594051;7853.410994175346;7859.882101768364;7867.9606601966625;8991.730248092568;9574.856377154487;9644.614215431304;10187.490625468548;11132.109431245319 04:50:17 INFO - PROCESS | 1960 | |3;mootools.html;1524.6645737937654;1536.277949363799;1765.5850875044362;1852.5183452302397;1892.6971684530479;7903.723369682048;8455.915440845589;8628.09405012474;8857.778555536115;8875.866861997076;8626.827463450727;8650.697225597105;8707.564621768917;8713.869291960626;8749.86875196871;2302.2517681753457;2479.528889510996;2482.379405148713;2482.466269752003;2483.776460118598;2442.117033916073;2487.8631675257852;2488.0421037900446;2492.239866840613;2502.5495410826134;2163.3726219396435;2420.903163873452;2441.426264827764;2477.417806815397;2479.814013948952;2433.9513209735796;2446.632273855659;2447.877606119687;2452.803775697949;2463.19946017545;2453.711801304312;2469.703635563726;2474.6411770293385;2474.6906636670415;2475.6781618389673;8717;8741.650333986632;8755.649774009033;8788;8794.912050879473;5400.972995135038;5545.750441230154;5549.278593782823;5559.972200139014;5589.161625756128;3594.137407022322;3630.6550877666577;3685.060309621056;3751.924961500782;3771.226898485831;1051.0645525482328;1063.085746258225;1069.566825435692;1096.714854137922;1098.7967226063204;11675.182737208399;11780.175387722862;11800.291982480992;11815.881841181565;11826.763464730657;4123.36087906375;4798.664093513421;4828.179209534387;4911.9754401227765;4957.702537847668;10035.197184225244;10037.849432258521;10052.195824334036;10066.094051535398;10067.69796906094;4558.908821823545;5395.433479484676;5422.942526207431;5442.6462279951675;5507.476789704971;4979.875503112451;5016.924746128811;5017.197248440232;5028.446870844277;5031.069252188357;3919.647231749156;3962.40563915415;4000.6399424051974;4030.2544029354663;4038.7778672173313;1100.49927283086;1224.1369834266998;1301.9088663793632;1313.2645718397537;1322.134002228542;1102.6581759654532;1108.1024370260116;1141.594733869481;1265.4748279464104;1373.8763511284033;7960.925275087905;8031.397645176635;8089.150639182801;8096;8323.583820808935;1184.390039129849;1195.3485350484007;1204.27141579345;1227.766724322376;1231.5504840733247;6264.310925798159;6287.2140982377205;6333.714982825784;6336.366363363627;6339.144215530844;10419.479026048668;10623.468826558641;10747.677569672922;10749.247552671239;10808.243422960475;9992.700218993441;10380.273380863418;10452.372857628567;10564.524596393181;10578;8204;8255.793605159919;8384.706535271236;8409.369297302726;8425.199606037417;7945.006874140732;7965.084015338311;8043.115257321573;8057.959710201646;8074.515529068275;8180.181981801772;9246.398984066014;9379.343445958717;9562.569684364082;9778.119969202806;9782.217422606032;9965.302428829913;9990.600375984879;10018.298719089593;10048.246381521269;7418.146913105062;7466.701331946661;7556.2443755624;7572.7728168155045;7577.318041376303;8056.516609003244;8147.959260203661;8186.426950113435;8210.876836847572;8305.46014509055;7578.242175782598;7709.306162445182;7788.688452461838;7835.098963619257;7863.449558530848;6468.741250349934;7345.522541034816;7619;7728.729494467667;7766.88349674744;7701.345385642059;7719.266669666373;7764.883526747216;7770.261825126604;7779.455438119504;6978.302169782981;6987.1266091738535;6995.930040699732;7063.470239732143;7083.787486375417;7088.645567721696;7098.396636285974;7109.857802844018;7160.856782864418;7195 04:50:17 INFO - PROCESS | 1960 | |4;prototype.html;308.4093960066473;319.9872403841841;327.0450285167311;331.8191585585856;334.79912052768344;6572.145621069254;6698;6709.899351509725;6747.493937954649;6764.425023872976;6696.229933557643;6774.458043356532;6782.152230971129;6787.185537735479;6792.490563207754;4996.600271978233;5017.673851199678;5026.1706818375105;5026.84382592004;5027.899442011176;4877.902441951159;4997.350344455216;5002.574781143607;5003.949960500385;5026.195808670614;4964.5531902128805;4982.402111746595;4984.37695288089;4985.302057711923;4989.625778066641;4966.279889416032;4974.228994505857;4983.127952608315;4983.626228032912;4985.401751789772;4237.152569486084;4238.978805105986;4247.108107297471;4249.235137675218;4251.744895306291;5633.971830140864;6285.371462853724;6320.115183874262;6531.673416329212;6569.93430065698;5818.912716309259;5869.918292896221;5875.882482350372;5886.823395298148;5917.881642367129;6780.796576102724;6987.7204911803465;7260.927390726078;7273.34539891407;7296.452766042568;4679.62562994963;4727.888946097664;4729.290606409032;4729.716217026955;4749.928751068736;7650.1967293433945;7651.770446886602;7652;7652.426068044919;7704.191059938737;4472.619827314649;4803.78382972767;4822.68652537584;4840.491748366371;4846.079244943449;4141.171765646883;4628.236341003697;4669.533046695371;4693.6949098308505;4751.952480475151;5663.8867222656145;5677.14842773579;5690.402507736628;5691.573132015115;5694.345150307768;6153.815385538441;6958.851789454785;7194.928050719531;7209.927900721031;7221.494495385377;1418.9641561660046;1514.7500662390582;1580.936762529509;1641.2778377513855;1646.703593353184;1036.429963520061;1047.4134484688445;1053.899879511445;1063.6277302944063;1064.1752641702742;6726.562773419712;6746.561473504206;6750.763723269662;6771.289014653489;6775.559588626724;6789.845726226554;7505.549667019996;7507.024086868672;7519.8496030079095;7562.697492100365;5473.8357849264585;6453.096566480696;6628.767993120217;6729.3270672933295;6747.865042699119;3892.5328960524917;3982.761034337949;4023.9597604023584;4024.0744628735556;4036.737612055266;7442.21856705049;7853.568053757098;7855.6464959076975;7867.685292588232;7874.716332263694;7452.4783265172;7720;7729.458937874408;7743.373891482852;7743.954566133612;6150.815475535741;7786.727464538714;7822.530648161129;7849.9215007850335;7855.175206603339;7496.362809161283;7628.694852205849;7643.312101910632;7668.769936901902;7681.462297639112;7477.327040566375;7482.625868706652;7485.812854678677;7504.662290196845;7505.174430812715;7698.384129269533;7975.680972761024;7981.561014144278;8009.8398032040195;8012.278894899487;4680.18096833046;4726.550977657117;4730.1958667026;4736.71579705205;4737.957649317144;7587.165411804807;7606.429517786299;7625.123110842324;7639.656215470428;7661.463697541119;6118.571699980958;7027.735007698663;7214.819629509304;7236.819079523054;7283;7308.123025237006;7310.342069213796;7334.596597187206;7342.816429589303;7345.853082938204;6911.550749201286;7076.823079422849;7142.321479459443;7144.249853765487;7195.208527062124;7296.233895440902;7315.780526584211;7333.779986600411;7336.633168341455;7345.449091318065;7179.748708795167;7186.7125314986815;7199.208087110309;7220.494565380373;7260.4554658399775 04:50:17 INFO - PROCESS | 1960 | |5;yui.html;595.5949954031258;635.4408120853648;664.5149041199924;672.1463741048868;725.07914948016;15095.849041509582;15294.923525382372;15357.769633455508;15399.153046582433;15409.845901540995;11557.306561606309;14374.568762937102;14386.208758518278;14400.855991440083;14440.133591984488;727.8944553039806;866.7356456280831;878.4641368765032;895.0870112485261;897.1432282170512;891.9910800892005;896.085992287866;900.7883147460342;901.1349104859343;902.0168016861619;804.4208170117536;919.8528235482324;939.3612343606345;942.9481378524179;945.2579724915943;922.9077092290785;931.4969916245186;931.7297983584753;933.4026223217146;935.2564711054728;665.903444000622;684.0833283400268;695.2526034512919;695.544418405945;696.2271878215178;14899;15077.321520531603;15121.621959450991;15124.924375378163;15154.86338524604;10726.73183170427;12898.613041608767;12990.805137922938;13025;13143.211407315592;10055.39667619945;10131.290809643328;10238.7440313992;10253.282270241087;10279.22905782062;3492.5634295713035;3502.1419752160627;3520.6479352064844;3522.6125126236093;3532.1875968527384;78867;81433.59283203546;82930.58534707288;84515;86081.84795380165;7575.356094731899;8406.28546573548;8457.957710211533;8539.59096749042;9553.61785528571;20390.89804550968;20611.793882061287;20780.168793248402;20834.374968750963;20894.477638058866;7344.889826652605;7449.590272534954;7614.581198034161;7675.194104619046;7811.843763124706;3508.4737289406794;4080.469538959916;4112.115895082572;4122.113745544722;4321.416608757841;2937.3684657798676;3487.633798451177;3531.5585551806025;3538.876139335111;3568.1614820517157;588.5867498851953;643.8004218692221;650.5413683353224;653.9803805885831;667.7329068372593;584.6258394627442;585.3590318601125;596.7821745063108;620.7516993202755;632.686820024091;8620.698275560451;8648.827023459495;8764.956175219084;8800.075992020873;8952.328575356874;588.3439964439705;617.5831313863124;626.0765371077715;626.4330780643525;630.1933525087895;4042.4946881639794;4303.462067241595;4329.19909816685;4377.233984052778;4412.823487060482;56570;102607;102649;102790.97209027964;102919;81757;82760.17239827524;84979.15020849713;85344;86302.13697863066;57990.71004645034;72382;72412.27587724161;72719;75160.24839751533;8366.581670916308;8382.413231073766;8476.27951624119;8659.653613855628;9265.72202833916;49438;50195.24707129469;51388.48611513837;51995.2200716982;52943.735281323345;49923.500764991884;66864;73188;73284.90072649022;73299.53400932059;10989.395583242998;11024.944875275572;11076.224664273746;11115.944420277847;11721.41392930333;11859;11900.702482438008;11946;12278.447469864057;12811.039172061946;9015.459072455673;10195.643152489627;11773.411329433666;11840.28958262507;11975.700607484883;11802.232854864405;11820.82268765952;11834.940825295818;11886;11989.64031079069;10436.542783574276;11111.166662500507;11333.716657083638;11789.469473873867;12153.331566763913;9267.582958766738;9463.432194068102;9541.761455963657;9550.522473876417;9902.455364954996;9020.458772473672;9499.287553433658;9553.379030363005;9682.533351945258;9774.31579789408 04:50:17 INFO - PROCESS | 1960 | __end_tp_report 04:50:17 INFO - PROCESS | 1960 | __start_cc_report 04:50:17 INFO - PROCESS | 1960 | _x_x_mozilla_cycle_collect,358 04:50:17 INFO - PROCESS | 1960 | __end_cc_report 04:50:17 INFO - PROCESS | 1960 | __startTimestamp1455799817924__endTimestamp 04:50:17 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | ------- Summary: start ------- 04:50:17 INFO - PROCESS | 1960 | Number of tests: 6 04:50:17 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | [#0] dojo.html Cycles:165 Average:5768.87 Median:5990.82 stddev:650.14 (10.9%) stddev-sans-first:621.33 04:50:17 INFO - PROCESS | 1960 | Values: 3247.9 3503.6 3544.3 3572.7 3579.9 5751.3 5800.9 5807.2 5809.7 5830.4 5638.6 5801.5 5859.5 5864.5 5878.8 5210.5 5249.6 5279.7 5313.8 5323.7 5179.8 5244.3 5340.0 5351.1 5370.3 5144.3 5156.5 5246.4 5250.7 5273.0 5190.2 5207.1 5234.7 5234.9 5238.5 5152.0 5222.8 5231.6 5238.7 5249.7 4938.9 5458.7 5536.7 5706.6 5737.2 6297.8 6303.8 6305.1 6328.1 6344.8 6187.5 6210.5 6294.7 6302.4 6334.0 5840.4 5870.1 5870.3 5876.2 5879.9 6301.4 6314.8 6320.5 6339.7 6343.8 6079.1 6142.7 6225.6 6227.3 6254.4 6260.0 6269.5 6273.7 6277.6 6286.6 4859.3 6068.6 6222.2 6283.2 6297.8 6190.8 6197.5 6247.3 6277.7 6281.7 4864.1 4946.8 4962.4 4964.3 4978.2 4343.7 4367.2 4467.4 4467.5 4484.6 5837.9 5943.4 5955.4 5959.8 5966.0 6273.6 6280.6 6285.6 6290.1 6336.2 4894.4 5715.5 5882.9 5896.7 6014.3 5364.2 5380.3 5396.4 5410.9 5432.2 6255.9 6331.1 6413.4 6432.0 6501.7 5743.9 6262.4 6267.7 6279.5 6295.9 6025.3 6416.3 6422.3 6422.7 6470.8 5257.7 6096.1 6171.5 6275.7 6304.9 6265.1 6269.1 6292.1 6293.4 6309.0 5000.2 5897.4 6141.5 6146.3 6228.3 6144.6 6201.8 6208.3 6224.1 6237.6 5985.6 6013.6 6050.2 6065.2 6126.9 5990.8 6053.7 6125.8 6188.2 6225.7 5976.0 5986.4 6020.8 6035.7 6059.4 04:50:17 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | [#1] ext.html Cycles:180 Average:65923.39 Median:38094.02 stddev:141009.30 (370.2%) stddev-sans-first:141319.17 04:50:17 INFO - PROCESS | 1960 | Values: 447.5 452.7 460.9 482.4 536.0 37191.4 37744.0 37838.6 37854.6 37916.6 39157.8 39503.8 39649.6 39717.4 39797.0 8115.7 9571.5 9616.0 9673.2 9681.5 9440.9 9624.6 9649.8 9657.2 9735.6 9702.4 9714.1 9728.2 9755.9 9784.1 8243.1 9722.7 9743.9 9746.3 9774.4 9607.1 9733.8 9757.2 9782.4 9806.8 38271.4 38374.8 38561.7 38685.4 38875.2 2700.5 2738.9 2752.9 3324.0 3529.8 28890.3 29011.9 29081.3 29344.1 29442.9 2801.5 2851.9 2854.5 2870.9 2997.4 493184.0 499413.0 500279.0 500779.0 503828.0 41994.0 59699.0 61152.0 61873.0 63635.7 56147.4 60958.0 61361.0 61447.7 61618.4 15851.5 16143.3 16237.5 16257.4 16294.5 12476.3 12530.9 12553.0 12553.8 12565.6 19146.6 19715.6 19932.8 19969.9 19977.9 8521.7 8740.1 8812.6 8832.3 8851.4 870.7 921.8 938.9 942.0 1000.7 27513.9 30001.4 30445.5 30498.1 30619.7 1023.2 1069.6 1070.5 1119.8 1167.9 11869.9 13888.7 14047.5 14219.9 14220.4 551854.0 556796.0 561007.0 562153.0 562760.0 55968.2 56349.7 56840.0 56865.0 56869.4 1386.3 1394.5 1404.9 1418.8 1427.2 26438.9 27294.2 27690.3 27700.2 27797.3 47387.0 48309.0 48781.3 48926.0 48942.8 520498.0 524919.0 528595.4 529146.0 529483.0 30432.0 32396.7 33234.0 33249.8 33346.2 40164.2 41090.6 41254.4 41698.0 42278.4 28873.4 34231.7 35228.0 35378.0 35684.8 34329.1 34597.0 35007.3 35022.8 35060.5 36293.5 36602.8 37083.4 37114.3 37117.3 28108.0 29844.4 30894.0 31155.8 32438.5 23861.6 24686.8 24945.4 25104.4 25137.6 04:50:17 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | [#2] jquery.html Cycles:180 Average:33914.92 Median:13215.09 stddev:106917.17 (809.1%) stddev-sans-first:107187.31 04:50:17 INFO - PROCESS | 1960 | Values: 306.6 359.4 359.9 366.8 368.6 15375.6 15499.5 18934.1 19038.2 20174.6 13863.0 15396.4 15553.8 18767.0 19630.5 5091.2 5343.9 5345.4 5352.4 5357.9 5126.3 5215.8 5230.2 5716.7 5883.0 3902.3 5604.3 5831.7 5840.2 5854.0 5728.2 5763.2 5821.3 5822.6 5858.9 5368.3 5611.4 5611.6 5623.7 5626.9 23502.4 23527.4 23911.2 23984.3 24011.0 2089.3 2137.0 2180.7 2348.5 2419.2 10073.2 10087.8 11107.0 12150.5 14103.3 1707.5 1719.0 1741.3 1782.3 1784.8 97070.5 100513.0 100912.0 102170.0 103897.0 9170.9 10951.9 11220.6 11237.8 11284.0 13315.4 13367.9 13382.9 13388.9 13402.9 8486.7 8511.2 8518.5 8566.6 8629.1 8627.1 8671.8 8686.5 8716.7 8728.8 4357.2 4411.6 4429.8 4429.8 4468.8 1824.7 1876.6 1922.6 1924.8 1926.7 331.6 365.6 389.4 394.1 420.2 10441.2 10950.5 11642.6 11727.2 11785.1 885.1 962.1 963.6 966.9 968.5 10368.6 10708.1 10739.7 10760.8 10808.6 503521.0 511341.0 518234.0 802388.0 809908.0 78183.6 124378.0 124412.0 126826.0 127030.1 1057.6 1162.3 1174.4 1185.6 1189.0 15523.5 17919.5 18310.4 18561.4 19062.9 37183.3 50755.7 51640.5 52932.0 54228.5 63291.7 65099.7 65837.7 66247.7 66301.7 5778.6 6424.8 7552.9 7614.9 7652.0 9571.5 12052.9 12070.5 12160.6 12321.4 10349.6 10366.7 10573.6 10687.6 10854.9 8225.8 10522.8 10716.3 10764.8 10956.1 10922.7 11078.4 11447.9 11461.5 11581.0 7656.8 7846.0 7853.4 7859.9 7868.0 8991.7 9574.9 9644.6 10187.5 11132.1 04:50:17 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | [#3] mootools.html Cycles:180 Average:6069.08 Median:5029.76 stddev:3161.13 (62.8%) stddev-sans-first:3151.54 04:50:17 INFO - PROCESS | 1960 | Values: 1524.7 1536.3 1765.6 1852.5 1892.7 7903.7 8455.9 8628.1 8857.8 8875.9 8626.8 8650.7 8707.6 8713.9 8749.9 2302.3 2479.5 2482.4 2482.5 2483.8 2442.1 2487.9 2488.0 2492.2 2502.5 2163.4 2420.9 2441.4 2477.4 2479.8 2434.0 2446.6 2447.9 2452.8 2463.2 2453.7 2469.7 2474.6 2474.7 2475.7 8717.0 8741.7 8755.6 8788.0 8794.9 5401.0 5545.8 5549.3 5560.0 5589.2 3594.1 3630.7 3685.1 3751.9 3771.2 1051.1 1063.1 1069.6 1096.7 1098.8 11675.2 11780.2 11800.3 11815.9 11826.8 4123.4 4798.7 4828.2 4912.0 4957.7 10035.2 10037.8 10052.2 10066.1 10067.7 4558.9 5395.4 5422.9 5442.6 5507.5 4979.9 5016.9 5017.2 5028.4 5031.1 3919.6 3962.4 4000.6 4030.3 4038.8 1100.5 1224.1 1301.9 1313.3 1322.1 1102.7 1108.1 1141.6 1265.5 1373.9 7960.9 8031.4 8089.2 8096.0 8323.6 1184.4 1195.3 1204.3 1227.8 1231.6 6264.3 6287.2 6333.7 6336.4 6339.1 10419.5 10623.5 10747.7 10749.2 10808.2 9992.7 10380.3 10452.4 10564.5 10578.0 8204.0 8255.8 8384.7 8409.4 8425.2 7945.0 7965.1 8043.1 8058.0 8074.5 8180.2 9246.4 9379.3 9562.6 9778.1 9782.2 9965.3 9990.6 10018.3 10048.2 7418.1 7466.7 7556.2 7572.8 7577.3 8056.5 8148.0 8186.4 8210.9 8305.5 7578.2 7709.3 7788.7 7835.1 7863.4 6468.7 7345.5 7619.0 7728.7 7766.9 7701.3 7719.3 7764.9 7770.3 7779.5 6978.3 6987.1 6995.9 7063.5 7083.8 7088.6 7098.4 7109.9 7160.9 7195.0 04:50:17 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | [#4] prototype.html Cycles:180 Average:5917.51 Median:6727.94 stddev:1912.98 (28.4%) stddev-sans-first:1871.45 04:50:17 INFO - PROCESS | 1960 | Values: 308.4 320.0 327.0 331.8 334.8 6572.1 6698.0 6709.9 6747.5 6764.4 6696.2 6774.5 6782.2 6787.2 6792.5 4996.6 5017.7 5026.2 5026.8 5027.9 4877.9 4997.4 5002.6 5003.9 5026.2 4964.6 4982.4 4984.4 4985.3 4989.6 4966.3 4974.2 4983.1 4983.6 4985.4 4237.2 4239.0 4247.1 4249.2 4251.7 5634.0 6285.4 6320.1 6531.7 6569.9 5818.9 5869.9 5875.9 5886.8 5917.9 6780.8 6987.7 7260.9 7273.3 7296.5 4679.6 4727.9 4729.3 4729.7 4749.9 7650.2 7651.8 7652.0 7652.4 7704.2 4472.6 4803.8 4822.7 4840.5 4846.1 4141.2 4628.2 4669.5 4693.7 4752.0 5663.9 5677.1 5690.4 5691.6 5694.3 6153.8 6958.9 7194.9 7209.9 7221.5 1419.0 1514.8 1580.9 1641.3 1646.7 1036.4 1047.4 1053.9 1063.6 1064.2 6726.6 6746.6 6750.8 6771.3 6775.6 6789.8 7505.5 7507.0 7519.8 7562.7 5473.8 6453.1 6628.8 6729.3 6747.9 3892.5 3982.8 4024.0 4024.1 4036.7 7442.2 7853.6 7855.6 7867.7 7874.7 7452.5 7720.0 7729.5 7743.4 7744.0 6150.8 7786.7 7822.5 7849.9 7855.2 7496.4 7628.7 7643.3 7668.8 7681.5 7477.3 7482.6 7485.8 7504.7 7505.2 7698.4 7975.7 7981.6 8009.8 8012.3 4680.2 4726.6 4730.2 4736.7 4738.0 7587.2 7606.4 7625.1 7639.7 7661.5 6118.6 7027.7 7214.8 7236.8 7283.0 7308.1 7310.3 7334.6 7342.8 7345.9 6911.6 7076.8 7142.3 7144.2 7195.2 7296.2 7315.8 7333.8 7336.6 7345.4 7179.7 7186.7 7199.2 7220.5 7260.5 04:50:17 INFO - PROCESS | 1960 | 04:50:17 INFO - PROCESS | 1960 | [#5] yui.html Cycles:180 Average:18581.08 Median:596.19 stddev:26603.90 (4462.3%) stddev-sans-first:26644.25 04:50:17 INFO - PROCESS | 1960 | Values: 595.6 635.4 664.5 672.1 725.1 15095.8 15294.9 15357.8 15399.2 15409.8 11557.3 14374.6 14386.2 14400.9 14440.1 727.9 866.7 878.5 895.1 897.1 892.0 896.1 900.8 901.1 902.0 804.4 919.9 939.4 942.9 945.3 922.9 931.5 931.7 933.4 935.3 665.9 684.1 695.3 695.5 696.2 14899.0 15077.3 15121.6 15124.9 15154.9 10726.7 12898.6 12990.8 13025.0 13143.2 10055.4 10131.3 10238.7 10253.3 10279.2 3492.6 3502.1 3520.6 3522.6 3532.2 78867.0 81433.6 82930.6 84515.0 86081.8 7575.4 8406.3 8458.0 8539.6 9553.6 20390.9 20611.8 20780.2 20834.4 20894.5 7344.9 7449.6 7614.6 7675.2 7811.8 3508.5 4080.5 4112.1 4122.1 4321.4 2937.4 3487.6 3531.6 3538.9 3568.2 588.6 643.8 650.5 654.0 667.7 584.6 585.4 596.8 620.8 632.7 8620.7 8648.8 8765.0 8800.1 8952.3 588.3 617.6 626.1 626.4 630.2 4042.5 4303.5 4329.2 4377.2 4412.8 56570.0 102607.0 102649.0 102791.0 102919.0 81757.0 82760.2 84979.2 85344.0 86302.1 57990.7 72382.0 72412.3 72719.0 75160.2 8366.6 8382.4 8476.3 8659.7 9265.7 49438.0 50195.2 51388.5 51995.2 52943.7 49923.5 66864.0 73188.0 73284.9 73299.5 10989.4 11024.9 11076.2 11115.9 11721.4 11859.0 11900.7 11946.0 12278.4 12811.0 9015.5 10195.6 11773.4 11840.3 11975.7 11802.2 11820.8 11834.9 11886.0 11989.6 10436.5 11111.2 11333.7 11789.5 12153.3 9267.6 9463.4 9541.8 9550.5 9902.5 9020.5 9499.3 9553.4 9682.5 9774.3 04:50:17 INFO - PROCESS | 1960 | -------- Summary: end -------- 04:50:17 INFO - PROCESS | 1960 | 04:50:18 INFO - TEST-INFO | 1960: exit 0 04:50:18 INFO - TEST-OK | dromaeo_css | took 1111043ms 04:50:18 INFO - TEST-START | kraken 04:50:18 INFO - operating with platform_type : mac_ 04:50:18 INFO - Initialising browser for kraken test... 04:50:18 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmp1mNwF1/profile http://localhost:49460/getInfo.html) 04:50:21 INFO - PROCESS | 1967 | __metrics Screen width/height:1600/1200 04:50:21 INFO - PROCESS | 1967 | colorDepth:24 04:50:21 INFO - PROCESS | 1967 | Browser inner width/height: 1024/689 04:50:21 INFO - PROCESS | 1967 | __metrics 04:50:21 ERROR - PROCESS | 1967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 04:50:22 INFO - TEST-INFO | 1967: exit 0 04:50:22 INFO - Browser initialized. 04:50:22 INFO - Running cycle 1/1 for kraken test... 04:50:22 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmp1mNwF1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:34 INFO - PROCESS | 1970 | RSS: Main: 256864256 04:50:34 INFO - PROCESS | 1970 | 04:50:36 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49460/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:37 INFO - PROCESS | 1970 | RSS: Main: 267669504 04:50:37 INFO - PROCESS | 1970 | 04:50:40 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49460/tests/kraken/driver.html?testName=audio-dft) 04:50:40 INFO - PROCESS | 1970 | RSS: Main: 276377600 04:50:40 INFO - PROCESS | 1970 | 04:50:44 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49460/tests/kraken/driver.html?testName=audio-fft) 04:50:44 INFO - PROCESS | 1970 | RSS: Main: 281104384 04:50:44 INFO - PROCESS | 1970 | 04:50:46 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49460/tests/kraken/driver.html?testName=audio-oscillator) 04:50:47 INFO - PROCESS | 1970 | RSS: Main: 283533312 04:50:47 INFO - PROCESS | 1970 | 04:50:49 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:50 INFO - PROCESS | 1970 | RSS: Main: 284434432 04:50:50 INFO - PROCESS | 1970 | 04:50:52 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49460/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:53 INFO - PROCESS | 1970 | RSS: Main: 283983872 04:50:53 INFO - PROCESS | 1970 | 04:50:56 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49460/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:57 INFO - PROCESS | 1970 | RSS: Main: 283541504 04:50:57 INFO - PROCESS | 1970 | 04:51:00 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49460/tests/kraken/driver.html?testName=json-parse-financial) 04:51:00 INFO - PROCESS | 1970 | RSS: Main: 284327936 04:51:00 INFO - PROCESS | 1970 | 04:51:02 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:03 INFO - PROCESS | 1970 | RSS: Main: 284045312 04:51:03 INFO - PROCESS | 1970 | 04:51:04 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49460/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:05 INFO - PROCESS | 1970 | RSS: Main: 284147712 04:51:05 INFO - PROCESS | 1970 | 04:51:07 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:08 INFO - PROCESS | 1970 | RSS: Main: 284721152 04:51:08 INFO - PROCESS | 1970 | 04:51:10 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:11 INFO - PROCESS | 1970 | RSS: Main: 284893184 04:51:11 INFO - PROCESS | 1970 | 04:51:14 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:14 INFO - PROCESS | 1970 | RSS: Main: 284815360 04:51:14 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | Cycle 1(1): loaded http://localhost:49460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49460/tests/kraken/driver.html?testName=ai-astar) 04:51:16 INFO - PROCESS | 1970 | RSS: Main: 286072832 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | __start_tp_report 04:51:16 INFO - PROCESS | 1970 | _x_x_mozilla_page_load 04:51:16 INFO - PROCESS | 1970 | _x_x_mozilla_page_load_details 04:51:16 INFO - PROCESS | 1970 | |i|pagename|runs| 04:51:16 INFO - PROCESS | 1970 | |0;ai-astar;116;108;113;114;114;125;114;115;116;113 04:51:16 INFO - PROCESS | 1970 | |1;audio-beat-detection;165;151;181;144;149;175;174;132;155;128 04:51:16 INFO - PROCESS | 1970 | |2;audio-dft;224;252;272;217;186;274;275;195;190;201 04:51:16 INFO - PROCESS | 1970 | |3;audio-fft;60;112;106;143;87;58;60;59;87;58 04:51:16 INFO - PROCESS | 1970 | |4;audio-oscillator;82;88;115;81;83;83;115;83;80;112 04:51:16 INFO - PROCESS | 1970 | |5;imaging-gaussian-blur;90;94;87;94;96;127;85;82;131;140 04:51:16 INFO - PROCESS | 1970 | |6;imaging-darkroom;114;150;131;149;145;96;96;95;98;96 04:51:16 INFO - PROCESS | 1970 | |7;imaging-desaturate;107;155;124;92;89;91;89;135;142;145 04:51:16 INFO - PROCESS | 1970 | |8;json-parse-financial;58;57;57;58;56;57;58;63;57;54 04:51:16 INFO - PROCESS | 1970 | |9;json-stringify-tinderbox;64;71;67;74;75;71;68;68;73;100 04:51:16 INFO - PROCESS | 1970 | |10;stanford-crypto-aes;98;87;84;76;94;113;98;88;86;84 04:51:16 INFO - PROCESS | 1970 | |11;stanford-crypto-ccm;127;123;135;135;134;134;115;137;144;116 04:51:16 INFO - PROCESS | 1970 | |12;stanford-crypto-pbkdf2;194;179;177;136;142;140;143;142;145;141 04:51:16 INFO - PROCESS | 1970 | |13;stanford-crypto-sha256-iterative;68;82;58;63;89;100;95;93;70;68 04:51:16 INFO - PROCESS | 1970 | __end_tp_report 04:51:16 INFO - PROCESS | 1970 | __start_cc_report 04:51:16 INFO - PROCESS | 1970 | _x_x_mozilla_cycle_collect,877 04:51:16 INFO - PROCESS | 1970 | __end_cc_report 04:51:16 INFO - PROCESS | 1970 | __startTimestamp1455799876773__endTimestamp 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | ------- Summary: start ------- 04:51:16 INFO - PROCESS | 1970 | Number of tests: 14 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:4.24 (3.7%) stddev-sans-first:4.47 04:51:16 INFO - PROCESS | 1970 | Values: 116.0 108.0 113.0 114.0 114.0 125.0 114.0 115.0 116.0 113.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:160.00 stddev:18.15 (11.3%) stddev-sans-first:18.92 04:51:16 INFO - PROCESS | 1970 | Values: 165.0 151.0 181.0 144.0 149.0 175.0 174.0 132.0 155.0 128.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#2] audio-dft Cycles:10 Average:228.60 Median:238.00 stddev:36.51 (15.3%) stddev-sans-first:38.69 04:51:16 INFO - PROCESS | 1970 | Values: 224.0 252.0 272.0 217.0 186.0 274.0 275.0 195.0 190.0 201.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#3] audio-fft Cycles:10 Average:83.00 Median:59.50 stddev:29.60 (49.7%) stddev-sans-first:30.20 04:51:16 INFO - PROCESS | 1970 | Values: 60.0 112.0 106.0 143.0 87.0 58.0 60.0 59.0 87.0 58.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.50 stddev:15.21 (18.4%) stddev-sans-first:15.68 04:51:16 INFO - PROCESS | 1970 | Values: 82.0 88.0 115.0 81.0 83.0 83.0 115.0 83.0 80.0 112.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:88.50 stddev:21.42 (24.2%) stddev-sans-first:22.23 04:51:16 INFO - PROCESS | 1970 | Values: 90.0 94.0 87.0 94.0 96.0 127.0 85.0 82.0 131.0 140.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#6] imaging-darkroom Cycles:10 Average:117.00 Median:95.50 stddev:24.20 (25.3%) stddev-sans-first:25.64 04:51:16 INFO - PROCESS | 1970 | Values: 114.0 150.0 131.0 149.0 145.0 96.0 96.0 95.0 98.0 96.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#7] imaging-desaturate Cycles:10 Average:116.90 Median:122.00 stddev:26.24 (21.5%) stddev-sans-first:27.58 04:51:16 INFO - PROCESS | 1970 | Values: 107.0 155.0 124.0 92.0 89.0 91.0 89.0 135.0 142.0 145.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:2.27 (4.0%) stddev-sans-first:2.40 04:51:16 INFO - PROCESS | 1970 | Values: 58.0 57.0 57.0 58.0 56.0 57.0 58.0 63.0 57.0 54.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:71.00 stddev:10.05 (14.2%) stddev-sans-first:10.11 04:51:16 INFO - PROCESS | 1970 | Values: 64.0 71.0 67.0 74.0 75.0 71.0 68.0 68.0 73.0 100.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:87.50 stddev:10.35 (11.8%) stddev-sans-first:10.64 04:51:16 INFO - PROCESS | 1970 | Values: 98.0 87.0 84.0 76.0 94.0 113.0 98.0 88.0 86.0 84.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:134.50 stddev:9.46 (7.0%) stddev-sans-first:9.97 04:51:16 INFO - PROCESS | 1970 | Values: 127.0 123.0 135.0 135.0 134.0 134.0 115.0 137.0 144.0 116.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:144.00 stddev:20.90 (14.5%) stddev-sans-first:16.38 04:51:16 INFO - PROCESS | 1970 | Values: 194.0 179.0 177.0 136.0 142.0 140.0 143.0 142.0 145.0 141.0 04:51:16 INFO - PROCESS | 1970 | 04:51:16 INFO - PROCESS | 1970 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.60 Median:76.00 stddev:14.98 (19.7%) stddev-sans-first:15.39 04:51:16 INFO - PROCESS | 1970 | Values: 68.0 82.0 58.0 63.0 89.0 100.0 95.0 93.0 70.0 68.0 04:51:16 INFO - PROCESS | 1970 | -------- Summary: end -------- 04:51:16 INFO - PROCESS | 1970 | 04:51:17 INFO - TEST-INFO | 1970: exit 0 04:51:17 INFO - TEST-OK | kraken | took 58985ms 04:51:17 INFO - SUITE-END | took 1170s 04:51:17 INFO - Completed test suite (00:19:30) 04:51:17 INFO - Working with test: dromaeo_css 04:51:17 INFO - Generating results file: dromaeo_css 04:51:17 INFO - Working with test: kraken 04:51:17 INFO - Generating results file: kraken 04:51:17 INFO - javascript benchmark 04:51:17 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 04:51:18 INFO - process_Request line: dromaeo_css 7478.84 graph.html#tests=[[72,64,61]] 04:51:18 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:18 INFO - process_Request line: kraken 1594.40 graph.html#tests=[[232,64,61]] 04:51:18 INFO - RETURN: dromaeo_css: 7478.84 04:51:18 INFO - RETURN: kraken: 1594.40 04:51:18 INFO - javascript benchmark 04:51:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3247.8538465769043, 3503.632118627544, 3544.308859772342, 3572.714182865371, 3579.874704385347, 5751.252337196159, 5800.883982320351, 5807.245058142446, 5809.651420914748, 5830.3586605473365, 5638.577106716992, 5801.47786699197, 5859.501942334907, 5864.530837532998, 5878.7648494060295, 5210.452902445255, 5249.580033597303, 5279.736013199344, 5313.840584782462, 5323.707196104213, 5179.818706345279, 5244.318238628992, 5340.0, 5351.063563876325, 5370.3287089113865, 5144.305518754995, 5156.510131537498, 5246.396664383587, 5250.684958902478, 5272.9981303552395, 5190.195519694454, 5207.088759467116, 5234.738263086831, 5234.92147617786, 5238.476152384731, 5151.974240128776, 5222.76497557607, 5231.607629427808, 5238.711870847102, 5249.685018898878, 4938.913439043405, 5458.6724796512335, 5536.667799932017, 5706.572007099443, 5737.225474560964, 6297.842553936142, 6303.779367722108, 6305.0857625644485, 6328.145700330442, 6344.777932772331, 6187.504999600066, 6210.534209934273, 6294.685265736694, 6302.369763023661, 6334.0, 5840.386759390245, 5870.119482077723, 5870.295564532284, 5876.236089308362, 5879.882402351929, 6301.369863013662, 6314.778982735582, 6320.494360451153, 6339.714712837934, 6343.841403964938, 6079.148919151322, 6142.7136481981925, 6225.564210505312, 6227.283862355796, 6254.3745625438005, 6260.0, 6269.46709529686, 6273.65494897785, 6277.560570760094, 6286.622802631857, 4859.2954021666665, 6068.6358818471035, 6222.191115155001, 6283.183186185766, 6297.842553936188, 6190.845228869314, 6197.4732147767945, 6247.250329960434, 6277.748890044439, 6281.654509001957, 4864.124457597595, 4946.802127914843, 4962.379702537183, 4964.255361695775, 4978.228374601942, 4343.652507799368, 4367.192069467159, 4467.352233926063, 4467.486239082482, 4484.573965473275, 5837.88324233513, 5943.405659434022, 5955.404459554096, 5959.761609535657, 5966.045432730829, 6273.592216505913, 6280.591761535486, 6285.59143655661, 6290.056491526308, 6336.20797400325, 4894.412670479565, 5715.485606295453, 5882.941170588239, 5896.734646940898, 6014.278286605635, 5364.249005139206, 5380.300560927054, 5396.379416367168, 5410.945890541123, 5432.158015507603, 6255.874882502416, 6331.113644089739, 6413.422791948654, 6431.967840160769, 6501.674916254168, 5743.942560574341, 6262.405071518198, 6267.749290028348, 6279.529035322278, 6295.937040629535, 6025.307089684742, 6416.32628573993, 6422.2614399344675, 6422.678866056772, 6470.773522926675, 5257.658252213594, 6096.085587161784, 6171.47542458896, 6275.717592708431, 6304.905426418699, 6265.060240963892, 6269.090981807703, 6292.119103325446, 6293.402126797947, 6309.0, 5000.199968005102, 5897.410258974069, 6141.4730411843775, 6146.262448506208, 6228.28374736893, 6144.617461071223, 6201.844953876189, 6208.286047104641, 6224.128621992834, 6237.625742455467, 5985.610935289366, 6013.5877710061295, 6050.183225264533, 6065.211522502046, 6126.908096378647, 5990.820275391745, 6053.697315134314, 6125.754969801158, 6188.226471691039, 6225.688715564294, 5975.970120149372, 5986.401359864153, 6020.849478762891, 6035.728392222272, 6059.424354686298], "unit": "score", "name": "dojo.html", "value": 5729.345381836052}, {"lowerIsBetter": false, "replicates": [447.50997657564955, 452.6785981952813, 460.86634875885994, 482.39941273114977, 535.9919601205982, 37191.442128368064, 37744.0, 37838.621613783886, 37854.621453785454, 37916.620833791654, 39157.804210978975, 39503.81488555341, 39649.60350396495, 39717.40423893637, 39797.0, 8115.675372985088, 9571.52142392881, 9616.0, 9673.226141908666, 9681.467519286436, 9440.905590944072, 9624.56689448973, 9649.807003859918, 9657.22742180624, 9735.610575576968, 9702.417854928726, 9714.07716266957, 9728.17310528606, 9755.853662195073, 9784.07051330126, 8243.134470880561, 9722.708318750449, 9743.902560974371, 9746.31775775696, 9774.364666296704, 9607.13535781783, 9733.805323893554, 9757.170640495566, 9782.364146330467, 9806.803863922752, 38271.42592861109, 38374.80812595947, 38561.65034223789, 38685.419718704245, 38875.22249554993, 2700.5139074966496, 2738.904138355148, 2752.931176720578, 3323.9695694334832, 3529.8058606776617, 28890.27774305638, 29011.854940725374, 29081.272968175752, 29344.11967640974, 29442.852785736148, 2801.495730768461, 2851.9144425667264, 2854.4576530459144, 2870.8851645934137, 2997.385535965122, 493184.0, 499413.0, 500279.0, 500779.0, 503828.0, 41994.0, 59699.0, 61152.0, 61873.0, 63635.681821590595, 56147.438525615034, 60958.0, 61361.0, 61447.69276153591, 61618.383816161266, 15851.52445426616, 16143.273552690158, 16237.51287461378, 16257.430989915296, 16294.511164665078, 12476.313802740937, 12530.937345313216, 12553.0, 12553.811692824615, 12565.560205392767, 19146.617067658568, 19715.605687886164, 19932.800671993093, 19969.9016554088, 19977.900110499355, 8521.744347669579, 8740.115761798592, 8812.647494100293, 8832.293416526663, 8851.380403371702, 870.7474832298562, 921.8386782313069, 938.877945867033, 941.9544305820534, 1000.7398076500017, 27513.862430687717, 30001.399972000876, 30445.543316850264, 30498.085057448312, 30619.693803061684, 1023.2121266624806, 1069.6095924987324, 1070.5450183671908, 1119.787240424333, 1167.8948894599357, 11869.881301186877, 13888.652783680287, 14047.508337208148, 14219.85780142206, 14220.431182752574, 551854.0, 556796.0, 561007.0, 562153.0, 562760.0, 55968.16047759287, 56349.71825140848, 56840.0, 56865.0, 56869.43130568724, 1386.3068465767117, 1394.4840409048718, 1404.9277315959082, 1418.7588110021115, 1427.215031732543, 26438.867805660848, 27294.181174564794, 27690.3077423058, 27700.16899492938, 27797.305067373476, 47387.0, 48309.0, 48781.268280976525, 48926.0, 48942.7764305881, 520498.0, 524919.0, 528595.3570232125, 529146.0, 529483.0, 30432.0, 32396.676033239364, 33234.0, 33249.83375083206, 33346.16634584155, 40164.1967160661, 41090.58909410868, 41254.38118428286, 41698.0, 42278.36582451204, 28873.422531549673, 34231.657683423844, 35228.0, 35378.0, 35684.821575891954, 34329.141771455914, 34597.0, 35007.299854003286, 35022.82488587541, 35060.47409288914, 36293.455598166576, 36602.8169859149, 37083.443748343256, 37114.25771484609, 37117.25765484621, 28108.016219432222, 29844.403111938074, 30894.0, 31155.844220778752, 32438.513422298212, 23861.642075368538, 24686.753132468446, 24945.376365591004, 25104.37239069038, 25137.622935655614], "unit": "score", "name": "ext.html", "value": 19305.711401061904}, {"lowerIsBetter": false, "replicates": [306.62438512821797, 359.35854499717993, 359.88663570975143, 366.7799320407756, 368.5927050609075, 15375.615609609766, 15499.535013949571, 18934.05329733513, 19038.238470461165, 20174.59650806983, 13862.960277979168, 15396.384144634201, 15553.766693499578, 18767.0, 19630.509237269074, 5091.210862316338, 5343.946560534384, 5345.3585569731495, 5352.411234764173, 5357.892842143155, 5126.333576635032, 5215.791368345262, 5230.189320655286, 5716.7141642917895, 5882.970585147068, 3902.2780785554764, 5604.299462567179, 5831.737571809279, 5840.240768700063, 5854.034084376073, 5728.226689396941, 5763.164341170507, 5821.27234095738, 5822.592418530705, 5858.857522783059, 5368.30212072432, 5611.382747897728, 5611.6352437091455, 5623.662580245157, 5626.887462250773, 23502.412439688975, 23527.41181470477, 23911.16310929109, 23984.28047158588, 24011.0, 2089.3314139475374, 2136.9893150534303, 2180.6728990651372, 2348.4598542335357, 2419.1774796569075, 10073.24450666203, 10087.798244035152, 11107.0, 12150.45322960469, 14103.294835258195, 1707.5218938697185, 1718.9857983789625, 1741.2599645150888, 1782.3494424535081, 1784.8393644572052, 97070.51464742632, 100513.0, 100912.0, 102170.0, 103896.96103038949, 9170.90829091714, 10951.945240273748, 11220.607278745205, 11237.83143252852, 11284.040856527123, 13315.40080696371, 13367.933160334136, 13382.866171338357, 13388.93305533466, 13402.93298533501, 8486.74539763808, 8511.191436813493, 8518.531480768617, 8566.61450234741, 8629.05080441151, 8627.137286271323, 8671.826563468696, 8686.522241276663, 8716.694915678048, 8728.825423491495, 4357.215701173755, 4411.602955733999, 4429.800658970354, 4429.822807087745, 4468.843590474317, 1824.6715591193713, 1876.6262518718813, 1922.6154769046248, 1924.7777661184969, 1926.6724656808376, 331.6169823853453, 365.59784237339244, 389.4080996884776, 394.10538078561507, 420.1890351621339, 10441.164706823436, 10950.452477376099, 11642.600177384462, 11727.179097463266, 11785.057195424346, 885.1369914333602, 962.0764066496242, 963.6386355116831, 966.9419834809934, 968.4698176880512, 10368.585256589802, 10708.1433485321, 10739.731506712395, 10760.838587421194, 10808.621698240524, 503521.0, 511341.0, 518234.0, 802388.0, 809908.0, 78183.60908195423, 124378.0, 124412.0, 126826.0, 127030.09454858185, 1057.619257067455, 1162.314234601589, 1174.3834486894277, 1185.6206014075585, 1188.9940550297192, 15523.45667901618, 17919.46241612754, 18310.359137430125, 18561.35035273759, 19062.856228626326, 37183.256334873695, 50755.74622126866, 51640.48359516507, 52932.0, 54228.457715422344, 63291.683541581995, 65099.67450162719, 65837.67081164563, 66247.66876165588, 66301.66849165723, 5778.566607504538, 6424.839379015562, 7552.9244707552225, 7614.923850761643, 7652.005239318853, 9571.473568953774, 12052.939735301268, 12070.489421093853, 12160.635180944586, 12321.445534951128, 10349.63776267827, 10366.740831478972, 10573.62992295266, 10687.625933092304, 10854.945725271324, 8225.753227403187, 10522.813499394302, 10716.303440276357, 10764.784704306026, 10956.123510119012, 10922.726931826768, 11078.390688512209, 11447.885521145015, 11461.48423320936, 11581.0, 7656.846863062596, 7846.019247594051, 7853.410994175346, 7859.882101768364, 7867.9606601966625, 8991.730248092568, 9574.856377154487, 9644.614215431304, 10187.490625468548, 11132.109431245319], "unit": "score", "name": "jquery.html", "value": 8754.882107494126}, {"lowerIsBetter": false, "replicates": [1524.6645737937654, 1536.277949363799, 1765.5850875044362, 1852.5183452302397, 1892.6971684530479, 7903.723369682048, 8455.915440845589, 8628.09405012474, 8857.778555536115, 8875.866861997076, 8626.827463450727, 8650.697225597105, 8707.564621768917, 8713.869291960626, 8749.86875196871, 2302.2517681753457, 2479.528889510996, 2482.379405148713, 2482.466269752003, 2483.776460118598, 2442.117033916073, 2487.8631675257852, 2488.0421037900446, 2492.239866840613, 2502.5495410826134, 2163.3726219396435, 2420.903163873452, 2441.426264827764, 2477.417806815397, 2479.814013948952, 2433.9513209735796, 2446.632273855659, 2447.877606119687, 2452.803775697949, 2463.19946017545, 2453.711801304312, 2469.703635563726, 2474.6411770293385, 2474.6906636670415, 2475.6781618389673, 8717.0, 8741.650333986632, 8755.649774009033, 8788.0, 8794.912050879473, 5400.972995135038, 5545.750441230154, 5549.278593782823, 5559.972200139014, 5589.161625756128, 3594.137407022322, 3630.6550877666577, 3685.060309621056, 3751.924961500782, 3771.226898485831, 1051.0645525482328, 1063.085746258225, 1069.566825435692, 1096.714854137922, 1098.7967226063204, 11675.182737208399, 11780.175387722862, 11800.291982480992, 11815.881841181565, 11826.763464730657, 4123.36087906375, 4798.664093513421, 4828.179209534387, 4911.9754401227765, 4957.702537847668, 10035.197184225244, 10037.849432258521, 10052.195824334036, 10066.094051535398, 10067.69796906094, 4558.908821823545, 5395.433479484676, 5422.942526207431, 5442.6462279951675, 5507.476789704971, 4979.875503112451, 5016.924746128811, 5017.197248440232, 5028.446870844277, 5031.069252188357, 3919.647231749156, 3962.40563915415, 4000.6399424051974, 4030.2544029354663, 4038.7778672173313, 1100.49927283086, 1224.1369834266998, 1301.9088663793632, 1313.2645718397537, 1322.134002228542, 1102.6581759654532, 1108.1024370260116, 1141.594733869481, 1265.4748279464104, 1373.8763511284033, 7960.925275087905, 8031.397645176635, 8089.150639182801, 8096.0, 8323.583820808935, 1184.390039129849, 1195.3485350484007, 1204.27141579345, 1227.766724322376, 1231.5504840733247, 6264.310925798159, 6287.2140982377205, 6333.714982825784, 6336.366363363627, 6339.144215530844, 10419.479026048668, 10623.468826558641, 10747.677569672922, 10749.247552671239, 10808.243422960475, 9992.700218993441, 10380.273380863418, 10452.372857628567, 10564.524596393181, 10578.0, 8204.0, 8255.793605159919, 8384.706535271236, 8409.369297302726, 8425.199606037417, 7945.006874140732, 7965.084015338311, 8043.115257321573, 8057.959710201646, 8074.515529068275, 8180.181981801772, 9246.398984066014, 9379.343445958717, 9562.569684364082, 9778.119969202806, 9782.217422606032, 9965.302428829913, 9990.600375984879, 10018.298719089593, 10048.246381521269, 7418.146913105062, 7466.701331946661, 7556.2443755624, 7572.7728168155045, 7577.318041376303, 8056.516609003244, 8147.959260203661, 8186.426950113435, 8210.876836847572, 8305.46014509055, 7578.242175782598, 7709.306162445182, 7788.688452461838, 7835.098963619257, 7863.449558530848, 6468.741250349934, 7345.522541034816, 7619.0, 7728.729494467667, 7766.88349674744, 7701.345385642059, 7719.266669666373, 7764.883526747216, 7770.261825126604, 7779.455438119504, 6978.302169782981, 6987.1266091738535, 6995.930040699732, 7063.470239732143, 7083.787486375417, 7088.645567721696, 7098.396636285974, 7109.857802844018, 7160.856782864418, 7195.0], "unit": "score", "name": "mootools.html", "value": 4961.026521277043}, {"lowerIsBetter": false, "replicates": [308.4093960066473, 319.9872403841841, 327.0450285167311, 331.8191585585856, 334.79912052768344, 6572.145621069254, 6698.0, 6709.899351509725, 6747.493937954649, 6764.425023872976, 6696.229933557643, 6774.458043356532, 6782.152230971129, 6787.185537735479, 6792.490563207754, 4996.600271978233, 5017.673851199678, 5026.1706818375105, 5026.84382592004, 5027.899442011176, 4877.902441951159, 4997.350344455216, 5002.574781143607, 5003.949960500385, 5026.195808670614, 4964.5531902128805, 4982.402111746595, 4984.37695288089, 4985.302057711923, 4989.625778066641, 4966.279889416032, 4974.228994505857, 4983.127952608315, 4983.626228032912, 4985.401751789772, 4237.152569486084, 4238.978805105986, 4247.108107297471, 4249.235137675218, 4251.744895306291, 5633.971830140864, 6285.371462853724, 6320.115183874262, 6531.673416329212, 6569.93430065698, 5818.912716309259, 5869.918292896221, 5875.882482350372, 5886.823395298148, 5917.881642367129, 6780.796576102724, 6987.7204911803465, 7260.927390726078, 7273.34539891407, 7296.452766042568, 4679.62562994963, 4727.888946097664, 4729.290606409032, 4729.716217026955, 4749.928751068736, 7650.1967293433945, 7651.770446886602, 7652.0, 7652.426068044919, 7704.191059938737, 4472.619827314649, 4803.78382972767, 4822.68652537584, 4840.491748366371, 4846.079244943449, 4141.171765646883, 4628.236341003697, 4669.533046695371, 4693.6949098308505, 4751.952480475151, 5663.8867222656145, 5677.14842773579, 5690.402507736628, 5691.573132015115, 5694.345150307768, 6153.815385538441, 6958.851789454785, 7194.928050719531, 7209.927900721031, 7221.494495385377, 1418.9641561660046, 1514.7500662390582, 1580.936762529509, 1641.2778377513855, 1646.703593353184, 1036.429963520061, 1047.4134484688445, 1053.899879511445, 1063.6277302944063, 1064.1752641702742, 6726.562773419712, 6746.561473504206, 6750.763723269662, 6771.289014653489, 6775.559588626724, 6789.845726226554, 7505.549667019996, 7507.024086868672, 7519.8496030079095, 7562.697492100365, 5473.8357849264585, 6453.096566480696, 6628.767993120217, 6729.3270672933295, 6747.865042699119, 3892.5328960524917, 3982.761034337949, 4023.9597604023584, 4024.0744628735556, 4036.737612055266, 7442.21856705049, 7853.568053757098, 7855.6464959076975, 7867.685292588232, 7874.716332263694, 7452.4783265172, 7720.0, 7729.458937874408, 7743.373891482852, 7743.954566133612, 6150.815475535741, 7786.727464538714, 7822.530648161129, 7849.9215007850335, 7855.175206603339, 7496.362809161283, 7628.694852205849, 7643.312101910632, 7668.769936901902, 7681.462297639112, 7477.327040566375, 7482.625868706652, 7485.812854678677, 7504.662290196845, 7505.174430812715, 7698.384129269533, 7975.680972761024, 7981.561014144278, 8009.8398032040195, 8012.278894899487, 4680.18096833046, 4726.550977657117, 4730.1958667026, 4736.71579705205, 4737.957649317144, 7587.165411804807, 7606.429517786299, 7625.123110842324, 7639.656215470428, 7661.463697541119, 6118.571699980958, 7027.735007698663, 7214.819629509304, 7236.819079523054, 7283.0, 7308.123025237006, 7310.342069213796, 7334.596597187206, 7342.816429589303, 7345.853082938204, 6911.550749201286, 7076.823079422849, 7142.321479459443, 7144.249853765487, 7195.208527062124, 7296.233895440902, 7315.780526584211, 7333.779986600411, 7336.633168341455, 7345.449091318065, 7179.748708795167, 7186.7125314986815, 7199.208087110309, 7220.494565380373, 7260.4554658399775], "unit": "score", "name": "prototype.html", "value": 5263.990026579875}, {"lowerIsBetter": false, "replicates": [595.5949954031258, 635.4408120853648, 664.5149041199924, 672.1463741048868, 725.07914948016, 15095.849041509582, 15294.923525382372, 15357.769633455508, 15399.153046582433, 15409.845901540995, 11557.306561606309, 14374.568762937102, 14386.208758518278, 14400.855991440083, 14440.133591984488, 727.8944553039806, 866.7356456280831, 878.4641368765032, 895.0870112485261, 897.1432282170512, 891.9910800892005, 896.085992287866, 900.7883147460342, 901.1349104859343, 902.0168016861619, 804.4208170117536, 919.8528235482324, 939.3612343606345, 942.9481378524179, 945.2579724915943, 922.9077092290785, 931.4969916245186, 931.7297983584753, 933.4026223217146, 935.2564711054728, 665.903444000622, 684.0833283400268, 695.2526034512919, 695.544418405945, 696.2271878215178, 14899.0, 15077.321520531603, 15121.621959450991, 15124.924375378163, 15154.86338524604, 10726.73183170427, 12898.613041608767, 12990.805137922938, 13025.0, 13143.211407315592, 10055.39667619945, 10131.290809643328, 10238.7440313992, 10253.282270241087, 10279.22905782062, 3492.5634295713035, 3502.1419752160627, 3520.6479352064844, 3522.6125126236093, 3532.1875968527384, 78867.0, 81433.59283203546, 82930.58534707288, 84515.0, 86081.84795380165, 7575.356094731899, 8406.28546573548, 8457.957710211533, 8539.59096749042, 9553.61785528571, 20390.89804550968, 20611.793882061287, 20780.168793248402, 20834.374968750963, 20894.477638058866, 7344.889826652605, 7449.590272534954, 7614.581198034161, 7675.194104619046, 7811.843763124706, 3508.4737289406794, 4080.469538959916, 4112.115895082572, 4122.113745544722, 4321.416608757841, 2937.3684657798676, 3487.633798451177, 3531.5585551806025, 3538.876139335111, 3568.1614820517157, 588.5867498851953, 643.8004218692221, 650.5413683353224, 653.9803805885831, 667.7329068372593, 584.6258394627442, 585.3590318601125, 596.7821745063108, 620.7516993202755, 632.686820024091, 8620.698275560451, 8648.827023459495, 8764.956175219084, 8800.075992020873, 8952.328575356874, 588.3439964439705, 617.5831313863124, 626.0765371077715, 626.4330780643525, 630.1933525087895, 4042.4946881639794, 4303.462067241595, 4329.19909816685, 4377.233984052778, 4412.823487060482, 56570.0, 102607.0, 102649.0, 102790.97209027964, 102919.0, 81757.0, 82760.17239827524, 84979.15020849713, 85344.0, 86302.13697863066, 57990.71004645034, 72382.0, 72412.27587724161, 72719.0, 75160.24839751533, 8366.581670916308, 8382.413231073766, 8476.27951624119, 8659.653613855628, 9265.72202833916, 49438.0, 50195.24707129469, 51388.48611513837, 51995.2200716982, 52943.735281323345, 49923.500764991884, 66864.0, 73188.0, 73284.90072649022, 73299.53400932059, 10989.395583242998, 11024.944875275572, 11076.224664273746, 11115.944420277847, 11721.41392930333, 11859.0, 11900.702482438008, 11946.0, 12278.447469864057, 12811.039172061946, 9015.459072455673, 10195.643152489627, 11773.411329433666, 11840.28958262507, 11975.700607484883, 11802.232854864405, 11820.82268765952, 11834.940825295818, 11886.0, 11989.64031079069, 10436.542783574276, 11111.166662500507, 11333.716657083638, 11789.469473873867, 12153.331566763913, 9267.582958766738, 9463.432194068102, 9541.761455963657, 9550.522473876417, 9902.455364954996, 9020.458772473672, 9499.287553433658, 9553.379030363005, 9682.533351945258, 9774.31579789408], "unit": "score", "name": "yui.html", "value": 6919.049605671588}], "name": "dromaeo_css", "value": 7478.8428772197385}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 113.0, 114.0, 114.0, 125.0, 114.0, 115.0, 116.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [165.0, 151.0, 181.0, 144.0, 149.0, 175.0, 174.0, 132.0, 155.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 155.4}, {"lowerIsBetter": true, "replicates": [224.0, 252.0, 272.0, 217.0, 186.0, 274.0, 275.0, 195.0, 190.0, 201.0], "unit": "score", "name": "audio-dft", "value": 228.6}, {"lowerIsBetter": true, "replicates": [60.0, 112.0, 106.0, 143.0, 87.0, 58.0, 60.0, 59.0, 87.0, 58.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [82.0, 88.0, 115.0, 81.0, 83.0, 83.0, 115.0, 83.0, 80.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 92.2}, {"lowerIsBetter": true, "replicates": [90.0, 94.0, 87.0, 94.0, 96.0, 127.0, 85.0, 82.0, 131.0, 140.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 102.6}, {"lowerIsBetter": true, "replicates": [114.0, 150.0, 131.0, 149.0, 145.0, 96.0, 96.0, 95.0, 98.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 117.0}, {"lowerIsBetter": true, "replicates": [107.0, 155.0, 124.0, 92.0, 89.0, 91.0, 89.0, 135.0, 142.0, 145.0], "unit": "score", "name": "imaging-desaturate", "value": 116.9}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 58.0, 56.0, 57.0, 58.0, 63.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [64.0, 71.0, 67.0, 74.0, 75.0, 71.0, 68.0, 68.0, 73.0, 100.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.1}, {"lowerIsBetter": true, "replicates": [98.0, 87.0, 84.0, 76.0, 94.0, 113.0, 98.0, 88.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.8}, {"lowerIsBetter": true, "replicates": [127.0, 123.0, 135.0, 135.0, 134.0, 134.0, 115.0, 137.0, 144.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.0}, {"lowerIsBetter": true, "replicates": [194.0, 179.0, 177.0, 136.0, 142.0, 140.0, 143.0, 142.0, 145.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.9}, {"lowerIsBetter": true, "replicates": [68.0, 82.0, 58.0, 63.0, 89.0, 100.0, 95.0, 93.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.6}], "name": "kraken", "value": 1594.3999999999999}]} 04:51:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1594.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7478.84"}}} 04:51:18 INFO - Return code: 0 04:51:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:18 ERROR - # TBPL SUCCESS # 04:51:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:18 INFO - 2016-02-18 04:51:18.686 screenresolution[1976:12445] starting screenresolution argv=screenresolution get 04:51:18 INFO - 2016-02-18 04:51:18.689 screenresolution[1976:12445] Display 0: 1600x1200x32@60 04:51:18 INFO - 2016-02-18 04:51:18.695 screenresolution[1977:12448] starting screenresolution argv=screenresolution list 04:51:18 INFO - Available Modes on Display 0 04:51:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:18 INFO - Intel Iris: 04:51:18 INFO - Chipset Model: Intel Iris 04:51:18 INFO - Type: GPU 04:51:18 INFO - Bus: Built-In 04:51:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:18 INFO - Vendor: Intel (0x8086) 04:51:18 INFO - Device ID: 0x0a2e 04:51:18 INFO - Revision ID: 0x0009 04:51:18 INFO - Displays: 04:51:18 INFO - Display: 04:51:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:18 INFO - Display Serial Number: 1600x1200 60 04:51:18 INFO - Main Display: Yes 04:51:18 INFO - Mirror: Off 04:51:18 INFO - Online: Yes 04:51:18 INFO - Rotation: Supported 04:51:18 INFO - Return code: 0 04:51:18 INFO - Running post-action listener: _resource_record_post_action 04:51:18 INFO - Running post-run listener: _resource_record_post_run 04:51:19 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1994752; Write bytes: 711367680; Read time: 24; Write time: 2110 04:51:19 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403536384; Write bytes: 398496768; Read time: 30280; Write time: 707 04:51:20 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 1134592; Write bytes: 303400960; Read time: 18; Write time: 1370 04:51:20 INFO - Running post-run listener: _upload_blobber_files 04:51:20 INFO - Blob upload gear active. 04:51:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:20 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 04:51:20 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'] 04:51:20 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 04:51:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:21 INFO - (blobuploader) - INFO - Done attempting. 04:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:22 INFO - (blobuploader) - INFO - Done attempting. 04:51:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:22 INFO - Return code: 0 04:51:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d28b1cecf48b0d78d8b2eed3054117f39241fa3bd03e288da6c4193a17a311f072e7872182626b1c3d3fbe33f28705622777c4c9144b1ef75bc3ab76c12860c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d8b59cfc045bda76f26748b1e95b59ca77af95ad5e12223c201bc450d7098f4e25b3a64122073dcf00abd2d823ecb9823a51ba1e88116d37c0ee3a8a1d66b8"} 04:51:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:22 INFO - Contents: 04:51:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d28b1cecf48b0d78d8b2eed3054117f39241fa3bd03e288da6c4193a17a311f072e7872182626b1c3d3fbe33f28705622777c4c9144b1ef75bc3ab76c12860c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d8b59cfc045bda76f26748b1e95b59ca77af95ad5e12223c201bc450d7098f4e25b3a64122073dcf00abd2d823ecb9823a51ba1e88116d37c0ee3a8a1d66b8"} 04:51:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:22 INFO - Copying logs to upload dir... 04:51:22 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.646432 ========= master_lag: 5.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-18 04:51:28.120215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-18 04:51:28.121476) ========= 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.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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/d28b1cecf48b0d78d8b2eed3054117f39241fa3bd03e288da6c4193a17a311f072e7872182626b1c3d3fbe33f28705622777c4c9144b1ef75bc3ab76c12860c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d8b59cfc045bda76f26748b1e95b59ca77af95ad5e12223c201bc450d7098f4e25b3a64122073dcf00abd2d823ecb9823a51ba1e88116d37c0ee3a8a1d66b8"} build_url:https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011096 build_url: 'https://queue.taskcluster.net/v1/task/b59Y5R1RRNyIQdjIGpJX8A/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/d28b1cecf48b0d78d8b2eed3054117f39241fa3bd03e288da6c4193a17a311f072e7872182626b1c3d3fbe33f28705622777c4c9144b1ef75bc3ab76c12860c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d8b59cfc045bda76f26748b1e95b59ca77af95ad5e12223c201bc450d7098f4e25b3a64122073dcf00abd2d823ecb9823a51ba1e88116d37c0ee3a8a1d66b8"}' ========= master_lag: 1.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-18 04:51:29.671418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:51:29.671766) ========= 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.D27sTTJmuh/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.gEDesf1AbK/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005225 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:51:29.730683) ========= ========= Started reboot skipped (results: 3, elapsed: 12 secs) (at 2016-02-18 04:51:29.731000) ========= ========= Finished reboot skipped (results: 3, elapsed: 12 secs) (at 2016-02-18 04:51:41.864345) ========= ========= Total master_lag: 7.29 =========