builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0014 starttime: 1456251403.02 results: success (0) buildid: 20160223030304 builduid: d32a9238d9644683b7ce63ab094970b9 revision: 789a12291942763bc1e3a89f97e0b82dc1c9d00b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.020437) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.021062) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.021576) ========= 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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005604 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.044851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.048213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.064921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.065287) ========= 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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.114623) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.115017) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.115629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.115996) ========= 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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-23 10:16:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2016-02-23 10:16:43 (143 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174803 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.307399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.311274) ========= 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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.019747 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.359889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.360246) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 789a12291942763bc1e3a89f97e0b82dc1c9d00b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 789a12291942763bc1e3a89f97e0b82dc1c9d00b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-23 10:16:43,430 truncating revision to first 12 chars 2016-02-23 10:16:43,430 Setting DEBUG logging. 2016-02-23 10:16:43,431 attempt 1/10 2016-02-23 10:16:43,431 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/789a12291942?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 10:16:43,696 unpacking tar archive at: mozilla-central-789a12291942/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.886099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.886458) ========= echo 789a12291942763bc1e3a89f97e0b82dc1c9d00b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'789a12291942763bc1e3a89f97e0b82dc1c9d00b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 789a12291942763bc1e3a89f97e0b82dc1c9d00b program finished with exit code 0 elapsedTime=0.004514 script_repo_revision: '789a12291942763bc1e3a89f97e0b82dc1c9d00b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.940785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.941116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:43.955359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-02-23 10:16:43.955677) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:16:44 INFO - MultiFileLogger online at 20160223 10:16:44 in /builds/slave/test 10:16:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:16:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:16:44 INFO - {'append_to_log': False, 10:16:44 INFO - 'base_work_dir': '/builds/slave/test', 10:16:44 INFO - 'blob_upload_branch': 'Firefox', 10:16:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:16:44 INFO - 'branch': 'Firefox', 10:16:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:16:44 INFO - 'config_files': ('talos/mac_config.py',), 10:16:44 INFO - 'default_actions': ('clobber', 10:16:44 INFO - 'read-buildbot-config', 10:16:44 INFO - 'download-and-extract', 10:16:44 INFO - 'populate-webroot', 10:16:44 INFO - 'create-virtualenv', 10:16:44 INFO - 'install', 10:16:44 INFO - 'run-tests'), 10:16:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:16:44 INFO - 'download_minidump_stackwalk': True, 10:16:44 INFO - 'download_symbols': 'ondemand', 10:16:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:16:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:16:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:16:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:16:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:16:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:16:44 INFO - 'installer_path': 'installer.exe', 10:16:44 INFO - 'log_level': 'info', 10:16:44 INFO - 'log_name': 'talos', 10:16:44 INFO - 'log_to_console': True, 10:16:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:16:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:16:44 INFO - 'opt_config_files': (), 10:16:44 INFO - 'pip_index': False, 10:16:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:16:44 INFO - 'cmd': ('bash', 10:16:44 INFO - '-c', 10:16:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:16:44 INFO - 'enabled': True, 10:16:44 INFO - 'halt_on_failure': False, 10:16:44 INFO - 'name': 'check_screen_resolution'},), 10:16:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:16:44 INFO - 'cmd': ('bash', 10:16:44 INFO - '-c', 10:16:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:16:44 INFO - 'enabled': True, 10:16:44 INFO - 'halt_on_failure': False, 10:16:44 INFO - 'name': 'check_screen_resolution'},), 10:16:44 INFO - 'run_cmd_checks_enabled': True, 10:16:44 INFO - 'sps_profile': False, 10:16:44 INFO - 'sps_profile_interval': 0, 10:16:44 INFO - 'suite': 'dromaeojs-e10s', 10:16:44 INFO - 'system_bits': '32', 10:16:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:16:44 INFO - 'title': 't-yosemite-r7-0014', 10:16:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:16:44 INFO - 'use_talos_json': True, 10:16:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:16:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:16:44 INFO - 'work_dir': 'build'} 10:16:44 INFO - ##### 10:16:44 INFO - ##### Running clobber step. 10:16:44 INFO - ##### 10:16:44 INFO - Running pre-action listener: _resource_record_pre_action 10:16:44 INFO - Running main action method: clobber 10:16:44 INFO - rmtree: /builds/slave/test/build 10:16:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:16:45 INFO - Running post-action listener: _resource_record_post_action 10:16:45 INFO - ##### 10:16:45 INFO - ##### Running read-buildbot-config step. 10:16:45 INFO - ##### 10:16:45 INFO - Running pre-action listener: _resource_record_pre_action 10:16:45 INFO - Running main action method: read_buildbot_config 10:16:45 INFO - Using buildbot properties: 10:16:45 INFO - { 10:16:45 INFO - "project": "", 10:16:45 INFO - "product": "firefox", 10:16:45 INFO - "script_repo_revision": "production", 10:16:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:16:45 INFO - "repository": "", 10:16:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:16:45 INFO - "buildid": "20160223030304", 10:16:45 INFO - "stage_platform": "macosx64", 10:16:45 INFO - "basedir": "/builds/slave/test", 10:16:45 INFO - "nightly_build": "True", 10:16:45 INFO - "buildnumber": 144, 10:16:45 INFO - "slavename": "t-yosemite-r7-0014", 10:16:45 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:16:45 INFO - "platform": "yosemite_r7", 10:16:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:16:45 INFO - "branch": "mozilla-central", 10:16:45 INFO - "repo_path": "mozilla-central", 10:16:45 INFO - "revision": "789a12291942763bc1e3a89f97e0b82dc1c9d00b", 10:16:45 INFO - "pgo_build": "False", 10:16:45 INFO - "builduid": "d32a9238d9644683b7ce63ab094970b9", 10:16:45 INFO - "slavebuilddir": "test" 10:16:45 INFO - } 10:16:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:16:45 INFO - Running post-action listener: _resource_record_post_action 10:16:45 INFO - ##### 10:16:45 INFO - ##### Running download-and-extract step. 10:16:45 INFO - ##### 10:16:45 INFO - Running pre-action listener: _resource_record_pre_action 10:16:45 INFO - Running main action method: download_and_extract 10:16:45 INFO - mkdir: /builds/slave/test/build/tests 10:16: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')]} 10:16:45 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json 10:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json 10:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:16:46 INFO - Downloaded 1277 bytes. 10:16:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:16:46 INFO - Using the following test package requirements: 10:16:46 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:16:46 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:16:46 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:16:46 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:16:46 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:16:46 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:16:46 INFO - u'jsshell-mac.zip'], 10:16:46 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:16:46 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:16:46 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:16:46 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:16:46 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:16:46 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:16:46 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:16:46 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:16:46 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:16:46 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:16:46 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:16:46 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:16:46 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:16:46 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')]} 10:16:46 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:16:47 INFO - Downloaded 17825545 bytes. 10:16:47 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'] 10:16:47 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 10:16:51 INFO - Return code: 0 10:16:51 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 10:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:51 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:16:52 INFO - Downloaded 17825545 bytes. 10:16:52 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'] 10:16:52 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 10:16:55 INFO - Return code: 0 10:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:55 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:16:56 INFO - Downloaded 10707015 bytes. 10:16:56 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'] 10:16:56 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 10:16:56 INFO - Return code: 0 10:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:56 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:16:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:16:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:16:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:16:59 INFO - Downloaded 111375537 bytes. 10:16:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:16:59 INFO - mkdir: /builds/slave/test/properties 10:16:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:16:59 INFO - Writing to file /builds/slave/test/properties/build_url 10:16:59 INFO - Contents: 10:16:59 INFO - build_url:https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:17:01 INFO - Running post-action listener: _resource_record_post_action 10:17:01 INFO - Running post-action listener: set_extra_try_arguments 10:17:01 INFO - ##### 10:17:01 INFO - ##### Running populate-webroot step. 10:17:01 INFO - ##### 10:17:01 INFO - Running pre-action listener: _resource_record_pre_action 10:17:01 INFO - Running main action method: populate_webroot 10:17:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:01 INFO - '--tppagecycles', 10:17:01 INFO - '7'], 10:17:01 INFO - 'tests': ['tsvgm']}}, 10:17:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:17:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:17:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:17:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:17:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:01 INFO - 'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:01 INFO - 'tests': ['damp', 'tps']}, 10:17:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:01 INFO - 'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['damp', 'tps']}, 10:17:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:17:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:01 INFO - 'other': {'tests': ['a11yr', 10:17:01 INFO - 'ts_paint', 10:17:01 INFO - 'tpaint', 10:17:01 INFO - 'sessionrestore', 10:17:01 INFO - 'sessionrestore_no_auto_restore']}, 10:17:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['a11yr', 10:17:01 INFO - 'ts_paint', 10:17:01 INFO - 'tpaint', 10:17:01 INFO - 'sessionrestore', 10:17:01 INFO - 'sessionrestore_no_auto_restore']}, 10:17:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['a11yr', 10:17:01 INFO - 'ts_paint', 10:17:01 INFO - 'tpaint', 10:17:01 INFO - 'sessionrestore', 10:17:01 INFO - 'sessionrestore_no_auto_restore']}, 10:17:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['a11yr', 10:17:01 INFO - 'ts_paint', 10:17:01 INFO - 'tpaint', 10:17:01 INFO - 'sessionrestore', 10:17:01 INFO - 'sessionrestore_no_auto_restore']}, 10:17:01 INFO - 'other_l64': {'tests': ['a11yr', 10:17:01 INFO - 'ts_paint', 10:17:01 INFO - 'tpaint', 10:17:01 INFO - 'sessionrestore', 10:17:01 INFO - 'sessionrestore_no_auto_restore']}, 10:17:01 INFO - 'other_nol64': {'tests': ['a11yr', 10:17:01 INFO - 'ts_paint', 10:17:01 INFO - 'tpaint', 10:17:01 INFO - 'sessionrestore', 10:17:01 INFO - 'sessionrestore_no_auto_restore']}, 10:17:01 INFO - 'svgr': {'tests': ['tsvgx', 10:17:01 INFO - 'tsvgr_opacity', 10:17:01 INFO - 'tart', 10:17:01 INFO - 'tscrollx', 10:17:01 INFO - 'cart']}, 10:17:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['tsvgx', 10:17:01 INFO - 'tsvgr_opacity', 10:17:01 INFO - 'tart', 10:17:01 INFO - 'tscrollx', 10:17:01 INFO - 'cart']}, 10:17:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:01 INFO - 'tests': ['tp5o']}, 10:17:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:01 INFO - 'talos_options': ['--e10s'], 10:17:01 INFO - 'tests': ['tp5o']}, 10:17:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:01 INFO - 'talos_options': ['--xperf_path', 10:17:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:01 INFO - 'tests': ['tp5n']}, 10:17:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:01 INFO - 'talos_options': ['--e10s', 10:17:01 INFO - '--xperf_path', 10:17:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:01 INFO - 'tests': ['tp5n']}}, 10:17:01 INFO - 'talos.zip': {'path': '', 10:17:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:01 INFO - Running post-action listener: _resource_record_post_action 10:17:01 INFO - ##### 10:17:01 INFO - ##### Running create-virtualenv step. 10:17:01 INFO - ##### 10:17:01 INFO - Running pre-action listener: _resource_record_pre_action 10:17:01 INFO - Running main action method: create_virtualenv 10:17:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17:01 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 10:17:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:01 INFO - Using real prefix '/tools/python27' 10:17:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:01 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:04 INFO - Installing pip.................done. 10:17:04 INFO - Return code: 0 10:17:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:04 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 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:04 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 10:17:04 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 10:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:04 INFO - 'HOME': '/Users/cltbld', 10:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:04 INFO - 'LOGNAME': 'cltbld', 10:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:04 INFO - 'MOZ_NO_REMOTE': '1', 10:17:04 INFO - 'NO_EM_RESTART': '1', 10:17:04 INFO - 'PAGER': '/bin/cat', 10:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:04 INFO - 'PWD': '/builds/slave/test', 10:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:04 INFO - 'SHELL': '/bin/bash', 10:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:04 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:04 INFO - 'USER': 'cltbld', 10:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:04 INFO - 'XPC_FLAGS': '0x0', 10:17:04 INFO - 'XPC_SERVICE_NAME': '0', 10:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:05 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 10:17:05 INFO - Cleaning up... 10:17:05 INFO - Return code: 0 10:17:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:05 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 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:05 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 10:17:05 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 10:17:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:05 INFO - 'HOME': '/Users/cltbld', 10:17:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:05 INFO - 'LOGNAME': 'cltbld', 10:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:05 INFO - 'MOZ_NO_REMOTE': '1', 10:17:05 INFO - 'NO_EM_RESTART': '1', 10:17:05 INFO - 'PAGER': '/bin/cat', 10:17:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:05 INFO - 'PWD': '/builds/slave/test', 10:17:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:05 INFO - 'SHELL': '/bin/bash', 10:17:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:05 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:05 INFO - 'USER': 'cltbld', 10:17:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:05 INFO - 'XPC_FLAGS': '0x0', 10:17:05 INFO - 'XPC_SERVICE_NAME': '0', 10:17:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:05 INFO - Downloading/unpacking psutil>=0.7.1 10:17:05 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 10:17:05 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 10:17:05 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 10:17:05 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 10:17:05 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 10:17:05 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 10:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:07 INFO - Installing collected packages: psutil 10:17:07 INFO - Running setup.py install for psutil 10:17:07 INFO - building 'psutil._psutil_osx' extension 10:17:07 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 10:17:08 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 10:17:08 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 10:17:08 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 10:17:08 INFO - building 'psutil._psutil_posix' extension 10:17:08 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 10:17:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:17:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:17:08 INFO - ^ 10:17:08 INFO - 1 warning generated. 10:17:08 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 10:17:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:08 INFO - Successfully installed psutil 10:17:08 INFO - Cleaning up... 10:17:08 INFO - Return code: 0 10:17:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:17:08 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')]} 10:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:08 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')]} 10:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:08 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 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:08 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 10:17:08 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 10:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:08 INFO - 'HOME': '/Users/cltbld', 10:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:08 INFO - 'LOGNAME': 'cltbld', 10:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:08 INFO - 'MOZ_NO_REMOTE': '1', 10:17:08 INFO - 'NO_EM_RESTART': '1', 10:17:08 INFO - 'PAGER': '/bin/cat', 10:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:08 INFO - 'PWD': '/builds/slave/test', 10:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:08 INFO - 'SHELL': '/bin/bash', 10:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:08 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:08 INFO - 'USER': 'cltbld', 10:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:08 INFO - 'XPC_FLAGS': '0x0', 10:17:08 INFO - 'XPC_SERVICE_NAME': '0', 10:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:17:08 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 10:17:08 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 10:17:08 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 10:17:08 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 10:17:08 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 10:17:08 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 10:17:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:17:11 INFO - Installing collected packages: mozsystemmonitor 10:17:11 INFO - Running setup.py install for mozsystemmonitor 10:17:11 INFO - Successfully installed mozsystemmonitor 10:17:11 INFO - Cleaning up... 10:17:11 INFO - Return code: 0 10:17:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:17:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:11 INFO - 'HOME': '/Users/cltbld', 10:17:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:11 INFO - 'LOGNAME': 'cltbld', 10:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:11 INFO - 'MOZ_NO_REMOTE': '1', 10:17:11 INFO - 'NO_EM_RESTART': '1', 10:17:11 INFO - 'PAGER': '/bin/cat', 10:17:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:11 INFO - 'PWD': '/builds/slave/test', 10:17:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:11 INFO - 'SHELL': '/bin/bash', 10:17:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:11 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:11 INFO - 'USER': 'cltbld', 10:17:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:11 INFO - 'XPC_FLAGS': '0x0', 10:17:11 INFO - 'XPC_SERVICE_NAME': '0', 10:17:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:11 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:14 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:15 INFO - Downloading docopt-0.6.1.tar.gz 10:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:15 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:15 INFO - Running setup.py install for blobuploader 10:17:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:15 INFO - Running setup.py install for requests 10:17:16 INFO - Running setup.py install for docopt 10:17:16 INFO - Successfully installed blobuploader requests docopt 10:17:16 INFO - Cleaning up... 10:17:16 INFO - Return code: 0 10:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:16 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 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:16 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 10:17:16 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 10:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:16 INFO - 'HOME': '/Users/cltbld', 10:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:16 INFO - 'LOGNAME': 'cltbld', 10:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:16 INFO - 'MOZ_NO_REMOTE': '1', 10:17:16 INFO - 'NO_EM_RESTART': '1', 10:17:16 INFO - 'PAGER': '/bin/cat', 10:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:16 INFO - 'PWD': '/builds/slave/test', 10:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:16 INFO - 'SHELL': '/bin/bash', 10:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:16 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:16 INFO - 'USER': 'cltbld', 10:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:16 INFO - 'XPC_FLAGS': '0x0', 10:17:16 INFO - 'XPC_SERVICE_NAME': '0', 10:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:16 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-nrGvVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:16 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-uJt7Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:16 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Zkrk2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:16 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-yTeFKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:16 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-zGFCH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-EbNhhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-_duGQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-4sPqW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-M02brb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2U1kFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-YporOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Puj4wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-t1crD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-EVYTAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-BxenHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Ecg6KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-c9LMiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:18 INFO - Running setup.py install for manifestparser 10:17:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:18 INFO - Running setup.py install for mozcrash 10:17:18 INFO - Running setup.py install for mozdebug 10:17:18 INFO - Running setup.py install for mozdevice 10:17:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:17:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:18 INFO - Running setup.py install for mozfile 10:17:19 INFO - Running setup.py install for mozhttpd 10:17:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:19 INFO - Running setup.py install for mozinfo 10:17:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:19 INFO - Running setup.py install for mozInstall 10:17:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:19 INFO - Running setup.py install for mozleak 10:17:19 INFO - Running setup.py install for mozlog 10:17:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:19 INFO - Running setup.py install for moznetwork 10:17:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:19 INFO - Running setup.py install for mozprocess 10:17:20 INFO - Running setup.py install for mozprofile 10:17:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:20 INFO - Running setup.py install for mozrunner 10:17:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:20 INFO - Running setup.py install for mozscreenshot 10:17:20 INFO - Running setup.py install for moztest 10:17:20 INFO - Running setup.py install for mozversion 10:17:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:20 INFO - Cleaning up... 10:17:20 INFO - Return code: 0 10:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:20 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 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:20 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 10:17:20 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 10:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:20 INFO - 'HOME': '/Users/cltbld', 10:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:20 INFO - 'LOGNAME': 'cltbld', 10:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:20 INFO - 'MOZ_NO_REMOTE': '1', 10:17:20 INFO - 'NO_EM_RESTART': '1', 10:17:20 INFO - 'PAGER': '/bin/cat', 10:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:20 INFO - 'PWD': '/builds/slave/test', 10:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:20 INFO - 'SHELL': '/bin/bash', 10:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:20 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:20 INFO - 'USER': 'cltbld', 10:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:20 INFO - 'XPC_FLAGS': '0x0', 10:17:20 INFO - 'XPC_SERVICE_NAME': '0', 10:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2YBnZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:21 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)) 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-gdqRKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:21 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)) 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-gX8loU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:21 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)) 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-N2A3Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:21 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)) 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-d_6oDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:21 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)) 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KP7tOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:21 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)) 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-JHroGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:21 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)) 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PWTeWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:21 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)) 10:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:21 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-XeciwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:22 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)) 10:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:22 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-xdpH8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:22 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)) 10:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:22 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-3vS13a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:22 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)) 10:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:22 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-phzOxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:22 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)) 10:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:22 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-oDSOcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:22 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)) 10:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:22 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-mpWHZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:22 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)) 10:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:22 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-cfEq0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:22 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)) 10:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:22 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-tKHtpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:22 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)) 10:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:22 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-SHbrjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:22 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)) 10:17:22 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)) 10:17:22 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)) 10:17:22 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)) 10:17:22 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)) 10:17:22 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)) 10:17:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:22 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 10:17:22 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 10:17:22 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 10:17:22 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 10:17:22 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 10:17:22 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 10:17:25 INFO - Downloading blessings-1.6.tar.gz 10:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:25 INFO - Installing collected packages: blessings 10:17:25 INFO - Running setup.py install for blessings 10:17:25 INFO - Successfully installed blessings 10:17:25 INFO - Cleaning up... 10:17:25 INFO - Return code: 0 10:17:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:25 INFO - Reading from file tmpfile_stdout 10:17:25 INFO - Current package versions: 10:17:25 INFO - blessings == 1.6 10:17:25 INFO - blobuploader == 1.2.4 10:17:25 INFO - docopt == 0.6.1 10:17:25 INFO - manifestparser == 1.1 10:17:25 INFO - mozInstall == 1.12 10:17:25 INFO - mozcrash == 0.16 10:17:25 INFO - mozdebug == 0.1 10:17:25 INFO - mozdevice == 0.48 10:17:25 INFO - mozfile == 1.2 10:17:25 INFO - mozhttpd == 0.7 10:17:25 INFO - mozinfo == 0.9 10:17:25 INFO - mozleak == 0.1 10:17:25 INFO - mozlog == 3.1 10:17:25 INFO - moznetwork == 0.27 10:17:25 INFO - mozprocess == 0.22 10:17:25 INFO - mozprofile == 0.28 10:17:25 INFO - mozrunner == 6.11 10:17:25 INFO - mozscreenshot == 0.1 10:17:25 INFO - mozsystemmonitor == 0.0 10:17:25 INFO - moztest == 0.7 10:17:25 INFO - mozversion == 1.4 10:17:25 INFO - psutil == 3.1.1 10:17:25 INFO - requests == 1.2.3 10:17:25 INFO - wsgiref == 0.1.2 10:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:25 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')]} 10:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:25 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')]} 10:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:25 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 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:25 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 10:17:25 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 10:17:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:25 INFO - 'HOME': '/Users/cltbld', 10:17:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:25 INFO - 'LOGNAME': 'cltbld', 10:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:25 INFO - 'MOZ_NO_REMOTE': '1', 10:17:25 INFO - 'NO_EM_RESTART': '1', 10:17:25 INFO - 'PAGER': '/bin/cat', 10:17:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:25 INFO - 'PWD': '/builds/slave/test', 10:17:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:25 INFO - 'SHELL': '/bin/bash', 10:17:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:25 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:25 INFO - 'USER': 'cltbld', 10:17:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:25 INFO - 'XPC_FLAGS': '0x0', 10:17:25 INFO - 'XPC_SERVICE_NAME': '0', 10:17:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 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)) 10:17:26 INFO - Cleaning up... 10:17:26 INFO - Return code: 0 10:17:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:26 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 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:26 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 10:17:26 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 10:17:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:26 INFO - 'HOME': '/Users/cltbld', 10:17:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:26 INFO - 'LOGNAME': 'cltbld', 10:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:26 INFO - 'MOZ_NO_REMOTE': '1', 10:17:26 INFO - 'NO_EM_RESTART': '1', 10:17:26 INFO - 'PAGER': '/bin/cat', 10:17:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:26 INFO - 'PWD': '/builds/slave/test', 10:17:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:26 INFO - 'SHELL': '/bin/bash', 10:17:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:26 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:26 INFO - 'USER': 'cltbld', 10:17:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:26 INFO - 'XPC_FLAGS': '0x0', 10:17:26 INFO - 'XPC_SERVICE_NAME': '0', 10:17:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:26 INFO - Downloading/unpacking jsonschema 10:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:28 INFO - Downloading/unpacking functools32 (from jsonschema) 10:17:28 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 10:17:28 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 10:17:28 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 10:17:28 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 10:17:28 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 10:17:28 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 10:17:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:29 INFO - warning: no files found matching '*.txt' 10:17:29 INFO - no previously-included directories found matching 'build' 10:17:29 INFO - no previously-included directories found matching 'dist' 10:17:29 INFO - no previously-included directories found matching '.git*' 10:17:29 INFO - Installing collected packages: jsonschema, functools32 10:17:29 INFO - Running setup.py install for functools32 10:17:29 INFO - warning: no files found matching '*.txt' 10:17:29 INFO - no previously-included directories found matching 'build' 10:17:29 INFO - no previously-included directories found matching 'dist' 10:17:29 INFO - no previously-included directories found matching '.git*' 10:17:29 INFO - Successfully installed jsonschema functools32 10:17:29 INFO - Cleaning up... 10:17:29 INFO - Return code: 0 10:17:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c941a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9484c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa32c732d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, '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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:29 INFO - 'HOME': '/Users/cltbld', 10:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:29 INFO - 'LOGNAME': 'cltbld', 10:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:29 INFO - 'MOZ_NO_REMOTE': '1', 10:17:29 INFO - 'NO_EM_RESTART': '1', 10:17:29 INFO - 'PAGER': '/bin/cat', 10:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:29 INFO - 'PWD': '/builds/slave/test', 10:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:29 INFO - 'SHELL': '/bin/bash', 10:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:17:29 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:29 INFO - 'USER': 'cltbld', 10:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:29 INFO - 'XPC_FLAGS': '0x0', 10:17:29 INFO - 'XPC_SERVICE_NAME': '0', 10:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:29 INFO - Downloading/unpacking flake8 10:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:17:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:17:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:17:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:17:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:17:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:17:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:17:33 INFO - no previously-included directories found matching 'docs/_build' 10:17:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:17:33 INFO - Running setup.py install for pep8 10:17:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:17:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:17:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:17:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:17:33 INFO - no previously-included directories found matching 'docs/_build' 10:17:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:17:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:17:33 INFO - Cleaning up... 10:17:33 INFO - Return code: 0 10:17:33 INFO - Running post-action listener: _resource_record_post_action 10:17:33 INFO - Running post-action listener: _start_resource_monitoring 10:17:33 INFO - Starting resource monitoring. 10:17:33 INFO - ##### 10:17:33 INFO - ##### Running install step. 10:17:33 INFO - ##### 10:17:33 INFO - Running pre-action listener: _resource_record_pre_action 10:17:33 INFO - Running main action method: install 10:17:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:33 INFO - Reading from file tmpfile_stdout 10:17:33 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:33 INFO - Reading from file tmpfile_stdout 10:17:33 INFO - Output received: 10:17:33 INFO - Usage: mozinstall [options] installer 10:17:33 INFO - Options: 10:17:33 INFO - -h, --help show this help message and exit 10:17:33 INFO - -d DEST, --destination=DEST 10:17:33 INFO - Directory to install application into. [default: 10:17:33 INFO - "/builds/slave/test"] 10:17:33 INFO - --app=APP Application being installed. [default: firefox] 10:17:33 INFO - mkdir: /builds/slave/test/build/application 10:17:33 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'] 10:17:33 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 10:18:08 INFO - Reading from file tmpfile_stdout 10:18:08 INFO - Output received: 10:18:08 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 10:18:08 INFO - Running post-action listener: _resource_record_post_action 10:18:08 INFO - ##### 10:18:08 INFO - ##### Running run-tests step. 10:18:08 INFO - ##### 10:18:08 INFO - Running pre-action listener: _resource_record_pre_action 10:18:08 INFO - Running main action method: run_tests 10:18:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:08 INFO - 2016-02-23 10:18:08.048 screenresolution[2052:14784] starting screenresolution argv=screenresolution get 10:18:08 INFO - 2016-02-23 10:18:08.051 screenresolution[2052:14784] Display 0: 1600x1200x32@60 10:18:08 INFO - 2016-02-23 10:18:08.057 screenresolution[2053:14786] starting screenresolution argv=screenresolution list 10:18:08 INFO - Available Modes on Display 0 10:18:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:08 INFO - Intel Iris: 10:18:08 INFO - Chipset Model: Intel Iris 10:18:08 INFO - Type: GPU 10:18:08 INFO - Bus: Built-In 10:18:08 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:08 INFO - Vendor: Intel (0x8086) 10:18:08 INFO - Device ID: 0x0a2e 10:18:08 INFO - Revision ID: 0x0009 10:18:08 INFO - Displays: 10:18:08 INFO - Display: 10:18:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:08 INFO - Display Serial Number: 1600x1200 60 10:18:08 INFO - Main Display: Yes 10:18:08 INFO - Mirror: Off 10:18:08 INFO - Online: Yes 10:18:08 INFO - Rotation: Supported 10:18:08 INFO - Return code: 0 10:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:08 INFO - Python 2.7.3 10:18:08 INFO - Return code: 0 10:18:08 INFO - grabbing minidump binary from tooltool 10:18:08 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')]} 10:18:08 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 0x10c7e5d30>, '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 0x10c609db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7dcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:08 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 10:18:08 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 10:18:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:08 INFO - Return code: 0 10:18:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:18:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:18:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:18:09 INFO - Return code: 0 10:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 10:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --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 10:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NDeQsJuXHN/Render', 10:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:09 INFO - 'HOME': '/Users/cltbld', 10:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:09 INFO - 'LOGNAME': 'cltbld', 10:18:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:09 INFO - 'MOZ_NO_REMOTE': '1', 10:18:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:09 INFO - 'NO_EM_RESTART': '1', 10:18:09 INFO - 'PAGER': '/bin/cat', 10:18:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:09 INFO - 'PWD': '/builds/slave/test', 10:18:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:09 INFO - 'SHELL': '/bin/bash', 10:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q2YHf5K1hL/Listeners', 10:18:09 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:09 INFO - 'USER': 'cltbld', 10:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:09 INFO - 'XPC_FLAGS': '0x0', 10:18:09 INFO - 'XPC_SERVICE_NAME': '0', 10:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 10:18:09 INFO - mozversion application_buildid: 20160223030304 10:18:09 INFO - mozversion application_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 10:18:09 INFO - mozversion application_display_name: Nightly 10:18:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:09 INFO - mozversion application_name: Firefox 10:18:09 INFO - mozversion application_remotingname: firefox 10:18:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:18:09 INFO - mozversion application_vendor: Mozilla 10:18:09 INFO - mozversion application_version: 47.0a1 10:18:09 INFO - mozversion platform_buildid: 20160223030304 10:18:09 INFO - mozversion platform_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 10:18:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:18:09 INFO - mozversion platform_version: 47.0a1 10:18:09 INFO - using testdate: 1456251489 10:18:09 INFO - actual date: 1456251489 10:18:10 INFO - starting webserver on 'localhost:51468' 10:18:10 INFO - SUITE-START | Running 2 tests 10:18:10 INFO - TEST-START | dromaeo_css 10:18:10 INFO - operating with platform_type : mac_ 10:18:10 INFO - Initialising browser for dromaeo_css test... 10:18:10 INFO - TEST-INFO | started process 2071 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpBJJS2L/profile http://localhost:51468/getInfo.html) 10:18:13 INFO - PROCESS | 2071 | __metrics Screen width/height:1600/1200 10:18:13 INFO - PROCESS | 2071 | colorDepth:24 10:18:13 INFO - PROCESS | 2071 | Browser inner width/height: 1024/689 10:18:13 INFO - PROCESS | 2071 | __metrics 10:18:13 ERROR - PROCESS | 2071 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 10:18:14 INFO - TEST-INFO | 2071: exit 0 10:18:14 INFO - Browser initialized. 10:18:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:14 INFO - TEST-INFO | started process 2076 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpBJJS2L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:26 INFO - PROCESS | 2076 | RSS: Main: 256970752 10:18:26 INFO - PROCESS | 2076 | 10:19:15 INFO - PROCESS | 2076 | 1456251555933 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] 10:21:27 INFO - PROCESS | 2076 | Cycle 1(1): loaded http://localhost:51468/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51468/tests/dromaeo/cssquery-ext.html) 10:21:28 INFO - PROCESS | 2076 | RSS: Main: 269443072 10:21:28 INFO - PROCESS | 2076 | 10:24:30 INFO - PROCESS | 2076 | Cycle 1(1): loaded http://localhost:51468/tests/dromaeo/cssquery-ext.html (next: http://localhost:51468/tests/dromaeo/cssquery-jquery.html) 10:24:30 INFO - PROCESS | 2076 | RSS: Main: 281669632 10:24:30 INFO - PROCESS | 2076 | 10:27:32 INFO - PROCESS | 2076 | Cycle 1(1): loaded http://localhost:51468/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51468/tests/dromaeo/cssquery-mootools.html) 10:27:33 INFO - PROCESS | 2076 | RSS: Main: 283152384 10:27:33 INFO - PROCESS | 2076 | 10:30:34 INFO - PROCESS | 2076 | Cycle 1(1): loaded http://localhost:51468/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51468/tests/dromaeo/cssquery-prototype.html) 10:30:35 INFO - PROCESS | 2076 | RSS: Main: 284827648 10:30:35 INFO - PROCESS | 2076 | 10:33:37 INFO - PROCESS | 2076 | Cycle 1(1): loaded http://localhost:51468/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51468/tests/dromaeo/cssquery-yui.html) 10:33:38 INFO - PROCESS | 2076 | RSS: Main: 288083968 10:33:38 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | Cycle 1(1): loaded http://localhost:51468/tests/dromaeo/cssquery-yui.html (next: http://localhost:51468/tests/dromaeo/cssquery-dojo.html) 10:36:40 INFO - PROCESS | 2076 | RSS: Main: 288145408 10:36:40 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | __start_tp_report 10:36:40 INFO - PROCESS | 2076 | _x_x_mozilla_page_load 10:36:40 INFO - PROCESS | 2076 | _x_x_mozilla_page_load_details 10:36:40 INFO - PROCESS | 2076 | |i|pagename|runs| 10:36:40 INFO - PROCESS | 2076 | |0;dojo.html;2911.490489164397;2936.6035585196;3573.4639804029375;3588.712902967763;3603.5675718913735;4637.976810115953;4714.339992401066;5738.856528586787;5795.565332600061;5821.796237131702;4640.373549570807;4835.830745923893;5697.145428185774;5699.287589051369;5843.707814609274;4272.401863739071;5237.397699264595;5261.552768014704;5261.815836445725;5324.254604355393;4371.912561748763;5289.994900968823;5310.097283461801;5325.946740532603;5339.305890234265;5173.508516690908;5261.605379596545;5286;5292.603054770869;5301.8939621207555;5278.208268759717;5290.867728306785;5300.390455097636;5358.490943360374;5382.246485491995;5230;5254.264402983586;5279.841604751864;5295.205719142121;5298.417174110883;5615.971920140373;5637.8590535236945;5642.069058605325;5677.545796336283;5687.573431992576;6121.696496193273;6219.2847822500535;6255.06174073888;6262.467690246334;6279.6860156992425;4838.274258861164;6118.929187392233;6132.172156758825;6240.812775616739;6244.6253224806205;5756.280464941882;5804.129380592903;5809.7676092956235;5814.47669709724;5839.124131380242;6171.691415429211;6251.843703907439;6273.247210334789;6281.434670879643;6323.462505686976;6165.506759459233;6189.102580125857;6193.597416167935;6205.596636218631;6218.31598524162;6239.282482514478;6239.75040998355;6261.248650161919;6282.057691346335;6283.08895210192;6123.601965872204;6156.876862462816;6253.312135665074;6256.562040657111;6311.873762524724;5756.107803290497;5765.971170144207;6201.875962480815;6203.6587987660205;6256.74973001084;4890.877728056756;4901.803927842918;4954.653174277838;4977.502249774993;4993.7503124843615;4406.427164468662;4418.403515525427;4441.600255976978;4462.085272519126;4477.2164871147415;5851.473367396869;5891.3814049525035;5896.764129434775;5915.319738230072;5977.163197152402;6058.4244496772735;6163.322034576193;6220.315765265817;6221.564490485713;6239.064140378889;5872.823815285548;5924.170616113747;5946.375630558816;5948.553858460633;5952.077427998667;5339.599530035263;5420.214068959979;5461.344638643309;5464.12573988168;5471.781128754806;6328.303886572473;6362.363763623508;6376.904346434807;6387.840303992251;6415.582987105823;6147.600405973598;6177.536684748572;6248.968755156195;6250.156228909039;6250.781222657367;6241.469475094668;6380.170577824853;6385.680715964276;6397.776077837253;6404.93595064062;6170.691465426621;6254.155688982111;6259.687015649109;6264.185655864709;6269.279032911274;6112.419320164578;6138.447539721446;6229.626222426669;6244.406781355764;6252.437280644764;5529.834104976857;5948.315943666534;6127.448529632355;6167.506599472121;6224.62652240867;4447.977760111308;4475.977620111878;4989.675671081368;5090.662125653585;6177.042558403455;5706.629069110494;5964.165016897551;6082.118092876596;6096.969515152396;6120.510359171345;6016.639001659914;6074.271087469532;6139.293981192041;6187.412195841388;6223.688815559294;4613.700109492872;5198.766055527435;5432.103702888979;6090.665013424305;6157.076438534255 10:36:40 INFO - PROCESS | 2076 | |1;ext.html;476.2998392363226;478.2873518457497;524.0017766155473;558.7457706743432;572.3932631410703;30907;36754.632453675455;36857.815710921444;37053.81473092637;37110.62889371102;38096.61903380966;38179;38558;38580;38618.22763544727;9366.765830854249;9564.80870382592;9565.713028609118;9582.856257156149;9617.903820961807;9466.574004169794;9589.520523973808;9723.27075469339;9767.951160244189;9790.265730070238;9699.806003879918;9739.464329461876;9797.26520510961;9803.852942205873;9820.656277030306;9709.41743495389;9745.805083898318;9767.853482197772;9772.706818795448;9789.36369136011;9523.142917137491;9623.56693948774;9632.036796320383;9634.662786802499;9681.806363872684;37576.24847503035;37701;37931.43102853459;37993.81003094994;38014.23971520554;3112.190074421931;3219.3561287742546;3225.516172574109;3226.1934516370907;3229.1765599771907;28368.716312836816;28511;28616.713832861613;29039.12882613525;29177.854110729524;2725;2726.3456770375165;2782.1792571191545;2949.1889730324333;2974.5389464633017;490012.5499372516;492366;495249;496885;497194;44599.55400445954;45083.09833803306;53321;66016.33983660198;66249.35002599841;33464;36223.27553448916;40846.9788255296;43789;43822.561774382484;15123.848761512465;15375.461858835111;15439.305231264396;15506.84493155054;15530.84469155294;10142.594296228068;12336.383180840921;12381.566645167375;12396.81404778929;12553.686157846127;14240.074395164282;14253.287335633177;14457.421703131968;14461.421543138367;14600.780988285183;6313.9368606314265;6416.839579010562;6435.581687190412;6462.806115816439;6471.708773105222;921.2675922641516;984;1081.9829360401197;1102.1458369763498;1107.1143085531542;30026.84986575097;30544.54183187254;30994.535081973787;31067.84466077655;31433.37133257368;1057.4501259345097;1061.8088744025995;1092.153580974735;1141.57191053355;1162.0877611075266;12719.809202861965;13400.731985360238;14203.715925681428;14474.710505790035;14488.91333150018;615819;629042;633519;637849;638125;58343;58782.70608646929;59282.40717592769;59411.40588594145;59429;1238.4984081447028;1417.3834382043844;1429.199648197013;1433.4481224728554;1571.6856628674311;30113.548296776004;30306.090817275515;30444;30682.079537613907;30934.0719778407;49075;49319.013619728124;49544.75227623839;49584;49840.75079624579;495158;498410;498808;498972;499723.0027699822;31413.743450261733;32059.839700801345;32502.349953000336;32579.18552036218;32912;42472.57527424686;42707.3593896098;43164.568354316056;43547.56452435562;43914.341284880116;35324.82337588296;36510.90467285879;36549.26901462009;36777.81611091927;37009.62990370062;34964.300713986086;35326.11684707903;35880.92357229287;35906.92279231627;36151.81924090363;29846.701532984393;34907;35414.64585354216;35949.1012724684;36326.455103174005;30558.777648893796;32143.678563214067;32276.83861580771;32464.02607921766;32617.836910815295;23999.52000959936;24352.756472435758;24514.50970980535;25559.872200638878;25565.23304300874 10:36:40 INFO - PROCESS | 2076 | |2;jquery.html;286.9870855811489;365.37703216016695;369.11044383036887;369.2006805266597;375.56059410489723;15243.466478673248;18744.625107497843;19038.42884713457;19727.01364931755;20622.072006759696;11615.303081815096;12060.914517693405;12066.879331206706;19124.904375478138;19443.70834437481;5167.328247327851;5272.051030814452;5281.603879709018;5339.5728341732565;5342.893142137155;5052.473763118441;5243.056249875021;5274.024305503475;5280.1815718563685;5286.233496143057;5215.269862219292;5243.239730239113;5609.719514024303;5850.853728656796;5858.297004359483;5511.118221084647;5731.111677689964;5732.140178973145;5775;5804.448577385163;4631.907361852744;5487.204355368449;5537.141743029837;5561.416051314594;5575.163725441216;12897;20459;23528.882355588114;23645.527089458286;23740.05039798406;1856.9164387602455;2128.7977642123974;2137.1237792505153;2296.8047715944167;2311.7457079721216;8100.635471403801;9584.712458626253;9730.562124704406;9904.801903961952;9918.851217231748;1661.858742006931;1688.3837399349272;1709.265016043101;1731.8354756298131;1798.2357498063402;106113;109420.4528977358;109705.90294097037;111511;111667;9465.763355916019;9874.901250987541;10237;11024.173187011007;11300.15248856339;12071.879281207252;13056.869431305566;13547.59357219285;13763.587092387244;13772.655683607789;8302.83394332122;8452.112528184452;8554.914450855536;8569.571521424028;8579.270761985177;8614.44006139599;8630.6979255727;8652.697155599524;8695.695650652324;8724.651013959498;4371.628411584988;4411.117776444724;4462.9107417851465;4463.598276155161;4500.167469018176;1861.5346163459135;1907.122723547156;1918.6834172361682;1920.7983161767813;1930.3533316339183;884.2218847414234;938.2822141062093;943.4197469919764;966.5891995901713;1064.9680509584725;16979.15104244783;20542.79457205409;21239.362819115453;21445;21524.784752152278;913.3743385780762;947.0907928388687;949.2500924269888;968.1431932739576;987.7283746969497;8792.8681069784;11101.38942358178;11117.666470005914;11188.720281993015;11191.216614836883;613773;614968;621372;633927;637509;99021;111024.22439439078;123077;129408.70591294154;129423;1053.3258714422775;1064.8668916385607;1073.7959787640323;1080.4057768227444;1090.4275255490932;13255.80116298237;18624.720629190844;18672.439826805217;18961.336353227573;19202.8079719201;42829;48272;49644.50355496399;51194.48805511897;55827.16259256033;66775.33224667885;76855.46289074299;77154.84267736101;77439.2256077432;79175.60412197902;8031.714925611874;8248.958755206426;8330.208630180123;8340.41617086798;8382.58087095655;9879.357841740264;12804.871951280367;13597.932010339884;13601.183928964294;13727.656808579866;11215.943920280346;11321.660350189508;11465;11534.480948357177;11621.95402413753;11450.942745286553;11561.190716649753;11564.323173140016;11830.994365479031;11928.582499612472;11282.266652667551;11729;11956.282623042645;11964.760704785682;11973.521059157536;6608.669566521751;8192.016957965083;8221.424500284922;8241.464304820167;8312.085670576353;9911.55398007077;10400.427976461368;10905.400202988912;11500.309981401142;11822.349770762346 10:36:40 INFO - PROCESS | 2076 | |3;mootools.html;1557.8597926186642;1570.6151992761775;1640.983590164098;1805.882617629854;1921.356345624216;7890;8566.657333706644;8826.514541700211;8846.778830529232;8855;8751.474911505298;8773.649054037847;8829.602667879944;8885.955570222157;8897.466152030882;2111.6515774897125;2471.0486462711806;2471.1721573272885;2498.912538061168;2502.862342571158;2061.494933741228;2477.306354220812;2488.7511248875057;2514.220591616605;2521.1932181701864;2442.5969714997004;2497.5878979968284;2506.7117281512587;2512.6984761828517;2521.067205134103;2493.5885578879374;2498.375406148463;2505.348609361561;2515.1071369663687;2533.4173140177772;2530.0132948150235;2552.2853600991753;2553.080890879282;2559.142687199772;2560.142352311978;8826.735197944072;8855.07021762712;8889.511076890769;8911.287097032222;8951.955240223822;5338.27933229013;5433.8369848904595;5485.917711234295;5501.339839219319;5508.20131080995;3613.8554457821656;3699.7780133192095;3746.7002639788752;3761.6238376162437;3769.0577355661085;1035.0322448510667;1043.5929987304958;1050.5272627317738;1085.4301491716833;1085.630885498934;12198.451069701796;12247;12253.816192757116;12354.888060074636;12382.938085309515;4195.056112374752;4335.674824388184;4804.06320767454;4838.758062096881;4861.975690121598;9333.813323733622;9472.384295020802;9536.28477864163;9537.61849526025;9549.952250238704;4666.953330466652;5336.332958380202;5440.238366628675;5485.424030476823;5506.669599824023;4471.530489298641;4872.975635121802;4964.429090654548;4990.800367985313;5080.847574572768;3815.751976121543;3821.331267028259;3859.864904728321;3876.302265592164;3876.4185372193833;1164.6855349055706;1186.3593659423814;1188.5483516263937;1201.0631707268344;1201.9519219231133;1064.5848119233506;1071.689210129054;1081.4700796609604;1222.9082818788627;1374.731927274192;8126.431149819574;8197.877031844528;8221.79445513867;8271.627776750061;8379.581020948928;463.6036189058374;488.61155381471104;507.82733870483474;512.2648998686897;514.9794008239703;6160.537959653044;6218.347073557302;6222.533310001768;6274.843128921813;6283.874322513524;10494.632687855888;10799.514021869034;10824.296420732784;10842.94578527118;11102.888971110347;10424.947875260576;10503.107235885036;10647.520861561248;10775.461226938622;10783.299085559414;8220.588970551567;8250.133735957637;8383;8410.873836892451;8452.57737113142;8066.637001335072;8072.313853322534;8123;8145.266925976691;8268;9548.140667339972;9753.12221900004;9799.971003044579;9829.361091529028;9879.851802223116;9770.267229957639;10071.34536255141;10119.190464762949;10127.088562029452;10238.744031399274;6637.966810165918;7437.181909990005;7465.813354665959;7498.737544185928;7629.809254768676;8134.593270336578;8176.46852954556;8196.67213311461;8261.876071859047;8272.214139656722;5937.91093133612;6020.4280593343565;6530.183727034121;6940;7448.1807001228735;6043.758249669964;6198.566100372931;7229.421646268391;7311.122665280201;7342.926570734225;6190.2571691397325;7807.726729564665;7825.726099586487;7835.098963619257;7896.7236146734585;7022.367986881205;7055.2591977841585;7060.8940865886025;7082.964585177041;7116.750913717995;7093.255208203064;7148.606826624586;7161.4986950912935;7191.748288809867;7216.3505284524645 10:36:40 INFO - PROCESS | 2076 | |4;prototype.html;317.32093320294575;323.12916689521734;326.37499189052966;333.74968773419926;334.3480213583513;5516.558675305981;6129.957907155783;6576.0135979602965;6640.236372817128;6670.266270710218;6711;6714.362135597123;6751.898721519181;6766.7631632892735;6781.287964763703;4993.054098082131;4994.300797888281;5013.997200559885;5019.272205530205;5023.095842748304;4997.675151115184;5017.147084995541;5019.52314530119;5024.874378140539;5044.092063428581;4945.7774400152075;4961.355023846912;4962.206047032476;4972.726500042496;4976.676516026447;4726.338312636233;4893.8776530586665;4966.255061740731;4971.45314015458;4984.728894131991;4083.693722970759;4126.00975765817;4128.1330920506725;4137.110521237948;4142.79286035697;6351.269603995507;6354.332795056545;6359.17330747;6366.808995730135;6369.426751592379;5490.533304669068;5618.775248990036;5626.831195064155;5633.718314084279;5641;7074.327938845801;7080.433565314814;7086.503944723871;7089.093471676588;7096.183938847047;4526.569975852289;4556.635469162459;4564.566366195206;4580.656450766206;4612.1698094343;5558.471945165203;6170.96914515429;7377.815554611124;7402.407807375397;7569;3790.3177428062663;4503.279475283939;4545.38637283969;4598.195315819718;4624.838130665411;3803.8858834235016;4677.95322046782;4684.929726054112;4701.64737644678;4708.482066972699;5615.719214039282;5649.4915457608195;5675.971620141955;5679.829605111853;5713.800016999385;5834.620749651259;7160.140783106061;7190.496665233383;7199.856002879913;7217.675204615805;1623.9675206495804;1644.7203975324223;1645.1856331116173;1645.5556999610037;1656.097426902341;1019.0421004255976;1051.847482115089;1058.7988282226506;1061.6708820265742;1068.893110688925;6429.903551446732;6716.194056713226;6802.183737951378;6813.420859226922;6817.488688348394;7229.385502232264;7483.962580187064;7505.324520793155;7505.437092218105;7506.28690274423;6774.559653622498;6780.016897549827;6788;6796.864062718718;6842.965785171043;3802.239552089593;3934.232824599233;3947.1710940702774;3965.72239943207;3967.3255546557157;7812.414068944852;7856.5678887661725;7869.095054068741;7878.527288362602;7925.722599708983;5689.857753556194;6070.694800617888;6574.276829548746;6983.825404364931;7721.65252563636;6265.279492858289;6683.899741503881;6714.899276510759;7842.607869606497;7850.136484986761;7206;7430.071241094864;7432.368248698921;7463.141738700119;7496.389720322071;7264.745733899288;7320.15818180916;7326.780196594111;7330.193678695446;7358.889616655862;7795.805104872424;7801.414893882868;7811.687532498637;7837.098733645704;7849.646765895434;4654.883627909329;4657.930131048105;4665.300204969281;4667.743274119956;4671.9299210512545;6844.035065178823;7121.252268511939;7370.852582948418;7407.185209627044;7431.851362972819;5896;7150.5352152109945;7180.281971802778;7216.134063912364;7228.566286022856;7207.882778169392;7216.314450127229;7217.953396757546;7219.422446204396;7253.56478611285;7034;7037.1555413350725;7042.436605071684;7045.401140903081;7069.22238553769;6933.341332573397;7164.283571642794;7185.065941427581;7219.6751146199595;7252;5714.228579141763;7019.684114214975;7031.226565077735;7061.682224299816;7084.858302833812 10:36:40 INFO - PROCESS | 2076 | |5;yui.html;661.4509956735913;709.9609521476317;712.7042277454857;734.9559026458412;737.7676032049903;14735;15077.321520531576;15085.094894306349;17059.658806823856;17278.654426911453;15852.365905363771;15865.04809711418;15903.761443578356;15993.84006159938;15996.76004859928;686.1217641418991;856.0668870930684;865.5628907401754;883.9602217900177;894.575076838503;858.9055203927563;879.7844528090595;883.5361435246515;884.7920738626418;885.1369914333505;920.2086205862953;924.6902287733617;924.7087167542236;927.3554879358815;927.5037854747677;897.7217062710548;899.2491269789733;913.634546181526;918.6095909238547;920.3879420185568;670.7451168555966;678.396227357652;681.4207923265235;685.1777866560147;685.3283781893722;15248.466303679428;15271.083734975826;15314.463993760164;15367.846321536754;15420.768688469681;12617.621471355875;12722;12814.103012789108;13106.541271055563;13189.392161464457;10101.595936162617;10240.180785537139;10377;10674.146068314516;10934.835977460345;3444.810535420551;3503.91240218994;3504.5093686883856;3504.7721898076543;3518.542589463379;77717;79213.81179282258;79517.60241198757;80192.59903700445;83205;9315.394499357655;9340.673076442292;9387.249020078378;9553.04469553053;9649.083337082966;20163.495912602008;20337;20357.389278321672;20361.287354942506;20363.8981805093;7354.96322518384;7527.8494430111095;7651.502652327581;7833.373330133576;8007.119216886138;4034.45534852797;4060.939085913714;4079.6736261099636;4082.510098788105;4086.6730661547003;3568.7323450741296;3593.3531964246163;3598.838052287653;3630.8184590770884;3630.945535816912;616.2481772237952;633.2432742872223;638.2213699286863;665.1917919727555;691.4502970138752;555.4390066033335;606.8088552106072;621.0745988477137;629.3571354354738;630.0391902348863;8549.316054715608;8670.26302764272;8720.8691869622;8834.160754728291;8880.756694062837;507.9822206222838;544.3957207499673;624.8250489862845;627.3538255596743;647.7894684227645;3842.558105817811;4077.918441631151;4083.6528895044253;4104.856330028435;4182.2681030820095;95078;95784;96657;98080.66314363216;98431;62268.44328891723;82961;83092;83971.16028839634;85315.72026419609;52929.735351323;71981.64009180025;72616;73453.53092938218;73632.26367736362;8758;8851.778705532413;8981.191692747423;8985.730428087169;9135.908640913505;48607.75696121497;51272.74363628158;52512.21231681451;52966.735166323924;53086;50761.74619126881;71478.49825256299;71915.64042179755;72542;73854;7527.865331649569;11088.667339979813;11098.667039988813;11214.102871770076;11420.71448213768;10200;12425.502979880703;12453.688657783629;12484.625461236177;12953;11532.94233528827;11735.354555499529;11895.643130706092;11948.880511194777;12058.698532536757;10688.305260158066;11356.091512679131;11515.963563279345;12095.455704493495;12368.257904525757;10950.56197752081;11702.903983605669;11786.469608867794;11915.463804128662;12231.633051008484;9186.954065229631;9347.579358928728;9470.905290947278;9896.10935015852;10124.341917775615;8627.137286271323;8833.29333653319;9294.535273236446;9603.371491765627;10077.949610251902 10:36:40 INFO - PROCESS | 2076 | __end_tp_report 10:36:40 INFO - PROCESS | 2076 | __start_cc_report 10:36:40 INFO - PROCESS | 2076 | _x_x_mozilla_cycle_collect,341 10:36:40 INFO - PROCESS | 2076 | __end_cc_report 10:36:40 INFO - PROCESS | 2076 | __startTimestamp1456252600919__endTimestamp 10:36:40 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | ------- Summary: start ------- 10:36:40 INFO - PROCESS | 2076 | Number of tests: 6 10:36:40 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | [#0] dojo.html Cycles:165 Average:5682.27 Median:5924.17 stddev:698.12 (11.8%) stddev-sans-first:665.57 10:36:40 INFO - PROCESS | 2076 | Values: 2911.5 2936.6 3573.5 3588.7 3603.6 4638.0 4714.3 5738.9 5795.6 5821.8 4640.4 4835.8 5697.1 5699.3 5843.7 4272.4 5237.4 5261.6 5261.8 5324.3 4371.9 5290.0 5310.1 5325.9 5339.3 5173.5 5261.6 5286.0 5292.6 5301.9 5278.2 5290.9 5300.4 5358.5 5382.2 5230.0 5254.3 5279.8 5295.2 5298.4 5616.0 5637.9 5642.1 5677.5 5687.6 6121.7 6219.3 6255.1 6262.5 6279.7 4838.3 6118.9 6132.2 6240.8 6244.6 5756.3 5804.1 5809.8 5814.5 5839.1 6171.7 6251.8 6273.2 6281.4 6323.5 6165.5 6189.1 6193.6 6205.6 6218.3 6239.3 6239.8 6261.2 6282.1 6283.1 6123.6 6156.9 6253.3 6256.6 6311.9 5756.1 5766.0 6201.9 6203.7 6256.7 4890.9 4901.8 4954.7 4977.5 4993.8 4406.4 4418.4 4441.6 4462.1 4477.2 5851.5 5891.4 5896.8 5915.3 5977.2 6058.4 6163.3 6220.3 6221.6 6239.1 5872.8 5924.2 5946.4 5948.6 5952.1 5339.6 5420.2 5461.3 5464.1 5471.8 6328.3 6362.4 6376.9 6387.8 6415.6 6147.6 6177.5 6249.0 6250.2 6250.8 6241.5 6380.2 6385.7 6397.8 6404.9 6170.7 6254.2 6259.7 6264.2 6269.3 6112.4 6138.4 6229.6 6244.4 6252.4 5529.8 5948.3 6127.4 6167.5 6224.6 4448.0 4476.0 4989.7 5090.7 6177.0 5706.6 5964.2 6082.1 6097.0 6120.5 6016.6 6074.3 6139.3 6187.4 6223.7 4613.7 5198.8 5432.1 6090.7 6157.1 10:36:40 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | [#1] ext.html Cycles:180 Average:66333.73 Median:36817.82 stddev:145649.67 (395.6%) stddev-sans-first:145974.32 10:36:40 INFO - PROCESS | 2076 | Values: 476.3 478.3 524.0 558.7 572.4 30907.0 36754.6 36857.8 37053.8 37110.6 38096.6 38179.0 38558.0 38580.0 38618.2 9366.8 9564.8 9565.7 9582.9 9617.9 9466.6 9589.5 9723.3 9768.0 9790.3 9699.8 9739.5 9797.3 9803.9 9820.7 9709.4 9745.8 9767.9 9772.7 9789.4 9523.1 9623.6 9632.0 9634.7 9681.8 37576.2 37701.0 37931.4 37993.8 38014.2 3112.2 3219.4 3225.5 3226.2 3229.2 28368.7 28511.0 28616.7 29039.1 29177.9 2725.0 2726.3 2782.2 2949.2 2974.5 490012.5 492366.0 495249.0 496885.0 497194.0 44599.6 45083.1 53321.0 66016.3 66249.4 33464.0 36223.3 40847.0 43789.0 43822.6 15123.8 15375.5 15439.3 15506.8 15530.8 10142.6 12336.4 12381.6 12396.8 12553.7 14240.1 14253.3 14457.4 14461.4 14600.8 6313.9 6416.8 6435.6 6462.8 6471.7 921.3 984.0 1082.0 1102.1 1107.1 30026.8 30544.5 30994.5 31067.8 31433.4 1057.5 1061.8 1092.2 1141.6 1162.1 12719.8 13400.7 14203.7 14474.7 14488.9 615819.0 629042.0 633519.0 637849.0 638125.0 58343.0 58782.7 59282.4 59411.4 59429.0 1238.5 1417.4 1429.2 1433.4 1571.7 30113.5 30306.1 30444.0 30682.1 30934.1 49075.0 49319.0 49544.8 49584.0 49840.8 495158.0 498410.0 498808.0 498972.0 499723.0 31413.7 32059.8 32502.3 32579.2 32912.0 42472.6 42707.4 43164.6 43547.6 43914.3 35324.8 36510.9 36549.3 36777.8 37009.6 34964.3 35326.1 35880.9 35906.9 36151.8 29846.7 34907.0 35414.6 35949.1 36326.5 30558.8 32143.7 32276.8 32464.0 32617.8 23999.5 24352.8 24514.5 25559.9 25565.2 10:36:40 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | [#2] jquery.html Cycles:180 Average:34616.13 Median:326.18 stddev:103636.77 (31772.7%) stddev-sans-first:103895.44 10:36:40 INFO - PROCESS | 2076 | Values: 287.0 365.4 369.1 369.2 375.6 15243.5 18744.6 19038.4 19727.0 20622.1 11615.3 12060.9 12066.9 19124.9 19443.7 5167.3 5272.1 5281.6 5339.6 5342.9 5052.5 5243.1 5274.0 5280.2 5286.2 5215.3 5243.2 5609.7 5850.9 5858.3 5511.1 5731.1 5732.1 5775.0 5804.4 4631.9 5487.2 5537.1 5561.4 5575.2 12897.0 20459.0 23528.9 23645.5 23740.1 1856.9 2128.8 2137.1 2296.8 2311.7 8100.6 9584.7 9730.6 9904.8 9918.9 1661.9 1688.4 1709.3 1731.8 1798.2 106113.0 109420.5 109705.9 111511.0 111667.0 9465.8 9874.9 10237.0 11024.2 11300.2 12071.9 13056.9 13547.6 13763.6 13772.7 8302.8 8452.1 8554.9 8569.6 8579.3 8614.4 8630.7 8652.7 8695.7 8724.7 4371.6 4411.1 4462.9 4463.6 4500.2 1861.5 1907.1 1918.7 1920.8 1930.4 884.2 938.3 943.4 966.6 1065.0 16979.2 20542.8 21239.4 21445.0 21524.8 913.4 947.1 949.3 968.1 987.7 8792.9 11101.4 11117.7 11188.7 11191.2 613773.0 614968.0 621372.0 633927.0 637509.0 99021.0 111024.2 123077.0 129408.7 129423.0 1053.3 1064.9 1073.8 1080.4 1090.4 13255.8 18624.7 18672.4 18961.3 19202.8 42829.0 48272.0 49644.5 51194.5 55827.2 66775.3 76855.5 77154.8 77439.2 79175.6 8031.7 8249.0 8330.2 8340.4 8382.6 9879.4 12804.9 13597.9 13601.2 13727.7 11215.9 11321.7 11465.0 11534.5 11622.0 11450.9 11561.2 11564.3 11831.0 11928.6 11282.3 11729.0 11956.3 11964.8 11973.5 6608.7 8192.0 8221.4 8241.5 8312.1 9911.6 10400.4 10905.4 11500.3 11822.3 10:36:40 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | [#3] mootools.html Cycles:180 Average:6021.29 Median:5337.31 stddev:3236.69 (60.6%) stddev-sans-first:3228.38 10:36:40 INFO - PROCESS | 2076 | Values: 1557.9 1570.6 1641.0 1805.9 1921.4 7890.0 8566.7 8826.5 8846.8 8855.0 8751.5 8773.6 8829.6 8886.0 8897.5 2111.7 2471.0 2471.2 2498.9 2502.9 2061.5 2477.3 2488.8 2514.2 2521.2 2442.6 2497.6 2506.7 2512.7 2521.1 2493.6 2498.4 2505.3 2515.1 2533.4 2530.0 2552.3 2553.1 2559.1 2560.1 8826.7 8855.1 8889.5 8911.3 8952.0 5338.3 5433.8 5485.9 5501.3 5508.2 3613.9 3699.8 3746.7 3761.6 3769.1 1035.0 1043.6 1050.5 1085.4 1085.6 12198.5 12247.0 12253.8 12354.9 12382.9 4195.1 4335.7 4804.1 4838.8 4862.0 9333.8 9472.4 9536.3 9537.6 9550.0 4667.0 5336.3 5440.2 5485.4 5506.7 4471.5 4873.0 4964.4 4990.8 5080.8 3815.8 3821.3 3859.9 3876.3 3876.4 1164.7 1186.4 1188.5 1201.1 1202.0 1064.6 1071.7 1081.5 1222.9 1374.7 8126.4 8197.9 8221.8 8271.6 8379.6 463.6 488.6 507.8 512.3 515.0 6160.5 6218.3 6222.5 6274.8 6283.9 10494.6 10799.5 10824.3 10842.9 11102.9 10424.9 10503.1 10647.5 10775.5 10783.3 8220.6 8250.1 8383.0 8410.9 8452.6 8066.6 8072.3 8123.0 8145.3 8268.0 9548.1 9753.1 9800.0 9829.4 9879.9 9770.3 10071.3 10119.2 10127.1 10238.7 6638.0 7437.2 7465.8 7498.7 7629.8 8134.6 8176.5 8196.7 8261.9 8272.2 5937.9 6020.4 6530.2 6940.0 7448.2 6043.8 6198.6 7229.4 7311.1 7342.9 6190.3 7807.7 7825.7 7835.1 7896.7 7022.4 7055.3 7060.9 7083.0 7116.8 7093.3 7148.6 7161.5 7191.7 7216.4 10:36:40 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | [#4] prototype.html Cycles:180 Average:5779.31 Median:6502.09 stddev:1856.65 (28.6%) stddev-sans-first:1816.04 10:36:40 INFO - PROCESS | 2076 | Values: 317.3 323.1 326.4 333.7 334.3 5516.6 6130.0 6576.0 6640.2 6670.3 6711.0 6714.4 6751.9 6766.8 6781.3 4993.1 4994.3 5014.0 5019.3 5023.1 4997.7 5017.1 5019.5 5024.9 5044.1 4945.8 4961.4 4962.2 4972.7 4976.7 4726.3 4893.9 4966.3 4971.5 4984.7 4083.7 4126.0 4128.1 4137.1 4142.8 6351.3 6354.3 6359.2 6366.8 6369.4 5490.5 5618.8 5626.8 5633.7 5641.0 7074.3 7080.4 7086.5 7089.1 7096.2 4526.6 4556.6 4564.6 4580.7 4612.2 5558.5 6171.0 7377.8 7402.4 7569.0 3790.3 4503.3 4545.4 4598.2 4624.8 3803.9 4678.0 4684.9 4701.6 4708.5 5615.7 5649.5 5676.0 5679.8 5713.8 5834.6 7160.1 7190.5 7199.9 7217.7 1624.0 1644.7 1645.2 1645.6 1656.1 1019.0 1051.8 1058.8 1061.7 1068.9 6429.9 6716.2 6802.2 6813.4 6817.5 7229.4 7484.0 7505.3 7505.4 7506.3 6774.6 6780.0 6788.0 6796.9 6843.0 3802.2 3934.2 3947.2 3965.7 3967.3 7812.4 7856.6 7869.1 7878.5 7925.7 5689.9 6070.7 6574.3 6983.8 7721.7 6265.3 6683.9 6714.9 7842.6 7850.1 7206.0 7430.1 7432.4 7463.1 7496.4 7264.7 7320.2 7326.8 7330.2 7358.9 7795.8 7801.4 7811.7 7837.1 7849.6 4654.9 4657.9 4665.3 4667.7 4671.9 6844.0 7121.3 7370.9 7407.2 7431.9 5896.0 7150.5 7180.3 7216.1 7228.6 7207.9 7216.3 7218.0 7219.4 7253.6 7034.0 7037.2 7042.4 7045.4 7069.2 6933.3 7164.3 7185.1 7219.7 7252.0 5714.2 7019.7 7031.2 7061.7 7084.9 10:36:40 INFO - PROCESS | 2076 | 10:36:40 INFO - PROCESS | 2076 | [#5] yui.html Cycles:180 Average:18589.50 Median:626.09 stddev:26203.89 (4185.3%) stddev-sans-first:26242.82 10:36:40 INFO - PROCESS | 2076 | Values: 661.5 710.0 712.7 735.0 737.8 14735.0 15077.3 15085.1 17059.7 17278.7 15852.4 15865.0 15903.8 15993.8 15996.8 686.1 856.1 865.6 884.0 894.6 858.9 879.8 883.5 884.8 885.1 920.2 924.7 924.7 927.4 927.5 897.7 899.2 913.6 918.6 920.4 670.7 678.4 681.4 685.2 685.3 15248.5 15271.1 15314.5 15367.8 15420.8 12617.6 12722.0 12814.1 13106.5 13189.4 10101.6 10240.2 10377.0 10674.1 10934.8 3444.8 3503.9 3504.5 3504.8 3518.5 77717.0 79213.8 79517.6 80192.6 83205.0 9315.4 9340.7 9387.2 9553.0 9649.1 20163.5 20337.0 20357.4 20361.3 20363.9 7355.0 7527.8 7651.5 7833.4 8007.1 4034.5 4060.9 4079.7 4082.5 4086.7 3568.7 3593.4 3598.8 3630.8 3630.9 616.2 633.2 638.2 665.2 691.5 555.4 606.8 621.1 629.4 630.0 8549.3 8670.3 8720.9 8834.2 8880.8 508.0 544.4 624.8 627.4 647.8 3842.6 4077.9 4083.7 4104.9 4182.3 95078.0 95784.0 96657.0 98080.7 98431.0 62268.4 82961.0 83092.0 83971.2 85315.7 52929.7 71981.6 72616.0 73453.5 73632.3 8758.0 8851.8 8981.2 8985.7 9135.9 48607.8 51272.7 52512.2 52966.7 53086.0 50761.7 71478.5 71915.6 72542.0 73854.0 7527.9 11088.7 11098.7 11214.1 11420.7 10200.0 12425.5 12453.7 12484.6 12953.0 11532.9 11735.4 11895.6 11948.9 12058.7 10688.3 11356.1 11516.0 12095.5 12368.3 10950.6 11702.9 11786.5 11915.5 12231.6 9187.0 9347.6 9470.9 9896.1 10124.3 8627.1 8833.3 9294.5 9603.4 10077.9 10:36:40 INFO - PROCESS | 2076 | -------- Summary: end -------- 10:36:40 INFO - PROCESS | 2076 | 10:36:41 INFO - TEST-INFO | 2076: exit 0 10:36:41 INFO - TEST-OK | dromaeo_css | took 1111192ms 10:36:41 INFO - TEST-START | kraken 10:36:41 INFO - operating with platform_type : mac_ 10:36:41 INFO - Initialising browser for kraken test... 10:36:41 INFO - TEST-INFO | started process 2082 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp0oDoNV/profile http://localhost:51468/getInfo.html) 10:36:44 INFO - PROCESS | 2082 | __metrics Screen width/height:1600/1200 10:36:44 INFO - PROCESS | 2082 | colorDepth:24 10:36:44 INFO - PROCESS | 2082 | Browser inner width/height: 1024/689 10:36:44 INFO - PROCESS | 2082 | __metrics 10:36:44 ERROR - PROCESS | 2082 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 10:36:44 INFO - TEST-INFO | 2082: exit 0 10:36:44 INFO - Browser initialized. 10:36:44 INFO - Running cycle 1/1 for kraken test... 10:36:44 INFO - TEST-INFO | started process 2086 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp0oDoNV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:57 INFO - PROCESS | 2086 | RSS: Main: 255971328 10:36:57 INFO - PROCESS | 2086 | 10:36:59 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51468/tests/kraken/driver.html?testName=audio-beat-detection) 10:37:00 INFO - PROCESS | 2086 | RSS: Main: 268750848 10:37:00 INFO - PROCESS | 2086 | 10:37:03 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51468/tests/kraken/driver.html?testName=audio-dft) 10:37:03 INFO - PROCESS | 2086 | RSS: Main: 278212608 10:37:03 INFO - PROCESS | 2086 | 10:37:07 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51468/tests/kraken/driver.html?testName=audio-fft) 10:37:07 INFO - PROCESS | 2086 | RSS: Main: 281169920 10:37:07 INFO - PROCESS | 2086 | 10:37:09 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51468/tests/kraken/driver.html?testName=audio-oscillator) 10:37:10 INFO - PROCESS | 2086 | RSS: Main: 283279360 10:37:10 INFO - PROCESS | 2086 | 10:37:12 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51468/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:37:12 INFO - PROCESS | 2086 | RSS: Main: 283713536 10:37:12 INFO - PROCESS | 2086 | 10:37:15 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51468/tests/kraken/driver.html?testName=imaging-darkroom) 10:37:16 INFO - PROCESS | 2086 | RSS: Main: 283131904 10:37:16 INFO - PROCESS | 2086 | 10:37:19 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51468/tests/kraken/driver.html?testName=imaging-desaturate) 10:37:19 INFO - PROCESS | 2086 | RSS: Main: 283213824 10:37:19 INFO - PROCESS | 2086 | 10:37:22 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51468/tests/kraken/driver.html?testName=json-parse-financial) 10:37:23 INFO - PROCESS | 2086 | RSS: Main: 283250688 10:37:23 INFO - PROCESS | 2086 | 10:37:24 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51468/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:37:25 INFO - PROCESS | 2086 | RSS: Main: 284483584 10:37:25 INFO - PROCESS | 2086 | 10:37:27 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51468/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:27 INFO - PROCESS | 2086 | RSS: Main: 284409856 10:37:27 INFO - PROCESS | 2086 | 10:37:29 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51468/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:30 INFO - PROCESS | 2086 | RSS: Main: 284491776 10:37:30 INFO - PROCESS | 2086 | 10:37:33 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:33 INFO - PROCESS | 2086 | RSS: Main: 283906048 10:37:33 INFO - PROCESS | 2086 | 10:37:36 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:37:36 INFO - PROCESS | 2086 | RSS: Main: 284495872 10:37:36 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | Cycle 1(1): loaded http://localhost:51468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51468/tests/kraken/driver.html?testName=ai-astar) 10:37:38 INFO - PROCESS | 2086 | RSS: Main: 284495872 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | __start_tp_report 10:37:38 INFO - PROCESS | 2086 | _x_x_mozilla_page_load 10:37:38 INFO - PROCESS | 2086 | _x_x_mozilla_page_load_details 10:37:38 INFO - PROCESS | 2086 | |i|pagename|runs| 10:37:38 INFO - PROCESS | 2086 | |0;ai-astar;154;95;153;94;165;113;149;96;110;158 10:37:38 INFO - PROCESS | 2086 | |1;audio-beat-detection;159;151;151;151;144;130;173;160;163;124 10:37:38 INFO - PROCESS | 2086 | |2;audio-dft;190;199;204;228;197;201;195;192;239;185 10:37:38 INFO - PROCESS | 2086 | |3;audio-fft;71;72;72;134;85;85;68;60;83;57 10:37:38 INFO - PROCESS | 2086 | |4;audio-oscillator;84;92;142;93;82;80;114;81;81;114 10:37:38 INFO - PROCESS | 2086 | |5;imaging-gaussian-blur;86;93;86;95;91;91;86;92;129;87 10:37:38 INFO - PROCESS | 2086 | |6;imaging-darkroom;95;102;97;97;96;97;95;97;96;96 10:37:38 INFO - PROCESS | 2086 | |7;imaging-desaturate;91;79;125;146;139;90;91;92;91;92 10:37:38 INFO - PROCESS | 2086 | |8;json-parse-financial;57;56;57;57;57;58;59;76;87;87 10:37:38 INFO - PROCESS | 2086 | |9;json-stringify-tinderbox;67;69;72;74;77;74;68;68;67;68 10:37:38 INFO - PROCESS | 2086 | |10;stanford-crypto-aes;85;89;85;85;85;85;84;86;85;86 10:37:38 INFO - PROCESS | 2086 | |11;stanford-crypto-ccm;136;137;139;126;126;152;144;126;131;121 10:37:38 INFO - PROCESS | 2086 | |12;stanford-crypto-pbkdf2;139;144;140;143;145;142;142;158;145;139 10:37:38 INFO - PROCESS | 2086 | |13;stanford-crypto-sha256-iterative;69;69;70;85;64;64;70;104;97;96 10:37:38 INFO - PROCESS | 2086 | __end_tp_report 10:37:38 INFO - PROCESS | 2086 | __start_cc_report 10:37:38 INFO - PROCESS | 2086 | _x_x_mozilla_cycle_collect,885 10:37:38 INFO - PROCESS | 2086 | __end_cc_report 10:37:38 INFO - PROCESS | 2086 | __startTimestamp1456252658919__endTimestamp 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | ------- Summary: start ------- 10:37:38 INFO - PROCESS | 2086 | Number of tests: 14 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#0] ai-astar Cycles:10 Average:128.70 Median:161.50 stddev:29.48 (18.3%) stddev-sans-first:29.82 10:37:38 INFO - PROCESS | 2086 | Values: 154.0 95.0 153.0 94.0 165.0 113.0 149.0 96.0 110.0 158.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:155.00 stddev:14.87 (9.6%) stddev-sans-first:15.46 10:37:38 INFO - PROCESS | 2086 | Values: 159.0 151.0 151.0 151.0 144.0 130.0 173.0 160.0 163.0 124.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#2] audio-dft Cycles:10 Average:203.00 Median:200.00 stddev:17.18 (8.6%) stddev-sans-first:17.56 10:37:38 INFO - PROCESS | 2086 | Values: 190.0 199.0 204.0 228.0 197.0 201.0 195.0 192.0 239.0 185.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#3] audio-fft Cycles:10 Average:78.70 Median:72.00 stddev:21.71 (30.1%) stddev-sans-first:22.84 10:37:38 INFO - PROCESS | 2086 | Values: 71.0 72.0 72.0 134.0 85.0 85.0 68.0 60.0 83.0 57.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:81.50 stddev:20.64 (25.3%) stddev-sans-first:21.41 10:37:38 INFO - PROCESS | 2086 | Values: 84.0 92.0 142.0 93.0 82.0 80.0 114.0 81.0 81.0 114.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#5] imaging-gaussian-blur Cycles:10 Average:93.60 Median:91.00 stddev:12.86 (14.1%) stddev-sans-first:13.34 10:37:38 INFO - PROCESS | 2086 | Values: 86.0 93.0 86.0 95.0 91.0 91.0 86.0 92.0 129.0 87.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:96.50 stddev:1.99 (2.1%) stddev-sans-first:2.00 10:37:38 INFO - PROCESS | 2086 | Values: 95.0 102.0 97.0 97.0 96.0 97.0 95.0 97.0 96.0 96.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#7] imaging-desaturate Cycles:10 Average:103.60 Median:91.00 stddev:23.67 (26.0%) stddev-sans-first:24.67 10:37:38 INFO - PROCESS | 2086 | Values: 91.0 79.0 125.0 146.0 139.0 90.0 91.0 92.0 91.0 92.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:58.50 stddev:12.96 (22.1%) stddev-sans-first:13.41 10:37:38 INFO - PROCESS | 2086 | Values: 57.0 56.0 57.0 57.0 57.0 58.0 59.0 76.0 87.0 87.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:3.57 (5.1%) stddev-sans-first:3.56 10:37:38 INFO - PROCESS | 2086 | Values: 67.0 69.0 72.0 74.0 77.0 74.0 68.0 68.0 67.0 68.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:1.35 (1.6%) stddev-sans-first:1.42 10:37:38 INFO - PROCESS | 2086 | Values: 85.0 89.0 85.0 85.0 85.0 85.0 84.0 86.0 85.0 86.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:136.50 stddev:9.61 (7.0%) stddev-sans-first:10.16 10:37:38 INFO - PROCESS | 2086 | Values: 136.0 137.0 139.0 126.0 126.0 152.0 144.0 126.0 131.0 121.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:143.50 stddev:5.50 (3.8%) stddev-sans-first:5.56 10:37:38 INFO - PROCESS | 2086 | Values: 139.0 144.0 140.0 143.0 145.0 142.0 142.0 158.0 145.0 139.0 10:37:38 INFO - PROCESS | 2086 | 10:37:38 INFO - PROCESS | 2086 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:70.00 stddev:15.22 (21.7%) stddev-sans-first:15.73 10:37:38 INFO - PROCESS | 2086 | Values: 69.0 69.0 70.0 85.0 64.0 64.0 70.0 104.0 97.0 96.0 10:37:38 INFO - PROCESS | 2086 | -------- Summary: end -------- 10:37:38 INFO - PROCESS | 2086 | 10:37:39 INFO - TEST-INFO | 2086: exit 0 10:37:39 INFO - TEST-OK | kraken | took 58461ms 10:37:39 INFO - SUITE-END | took 1169s 10:37:40 INFO - Completed test suite (00:19:29) 10:37:40 INFO - Working with test: dromaeo_css 10:37:40 INFO - Generating results file: dromaeo_css 10:37:40 INFO - Working with test: kraken 10:37:40 INFO - Generating results file: kraken 10:37:40 INFO - javascript benchmark 10:37:40 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:37:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 10:37:40 INFO - process_Request line: dromaeo_css 7443.79 graph.html#tests=[[72,1,61]] 10:37:40 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:37:40 INFO - process_Request line: kraken 1528.60 graph.html#tests=[[232,1,61]] 10:37:40 INFO - RETURN: dromaeo_css: 7443.79 10:37:40 INFO - RETURN: kraken: 1528.60 10:37:40 INFO - javascript benchmark 10:37:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2911.490489164397, 2936.6035585196, 3573.4639804029375, 3588.712902967763, 3603.5675718913735, 4637.976810115953, 4714.339992401066, 5738.856528586787, 5795.565332600061, 5821.796237131702, 4640.373549570807, 4835.830745923893, 5697.145428185774, 5699.287589051369, 5843.707814609274, 4272.401863739071, 5237.397699264595, 5261.552768014704, 5261.815836445725, 5324.254604355393, 4371.912561748763, 5289.994900968823, 5310.097283461801, 5325.946740532603, 5339.305890234265, 5173.508516690908, 5261.605379596545, 5286.0, 5292.603054770869, 5301.8939621207555, 5278.208268759717, 5290.867728306785, 5300.390455097636, 5358.490943360374, 5382.246485491995, 5230.0, 5254.264402983586, 5279.841604751864, 5295.205719142121, 5298.417174110883, 5615.971920140373, 5637.8590535236945, 5642.069058605325, 5677.545796336283, 5687.573431992576, 6121.696496193273, 6219.2847822500535, 6255.06174073888, 6262.467690246334, 6279.6860156992425, 4838.274258861164, 6118.929187392233, 6132.172156758825, 6240.812775616739, 6244.6253224806205, 5756.280464941882, 5804.129380592903, 5809.7676092956235, 5814.47669709724, 5839.124131380242, 6171.691415429211, 6251.843703907439, 6273.247210334789, 6281.434670879643, 6323.462505686976, 6165.506759459233, 6189.102580125857, 6193.597416167935, 6205.596636218631, 6218.31598524162, 6239.282482514478, 6239.75040998355, 6261.248650161919, 6282.057691346335, 6283.08895210192, 6123.601965872204, 6156.876862462816, 6253.312135665074, 6256.562040657111, 6311.873762524724, 5756.107803290497, 5765.971170144207, 6201.875962480815, 6203.6587987660205, 6256.74973001084, 4890.877728056756, 4901.803927842918, 4954.653174277838, 4977.502249774993, 4993.7503124843615, 4406.427164468662, 4418.403515525427, 4441.600255976978, 4462.085272519126, 4477.2164871147415, 5851.473367396869, 5891.3814049525035, 5896.764129434775, 5915.319738230072, 5977.163197152402, 6058.4244496772735, 6163.322034576193, 6220.315765265817, 6221.564490485713, 6239.064140378889, 5872.823815285548, 5924.170616113747, 5946.375630558816, 5948.553858460633, 5952.077427998667, 5339.599530035263, 5420.214068959979, 5461.344638643309, 5464.12573988168, 5471.781128754806, 6328.303886572473, 6362.363763623508, 6376.904346434807, 6387.840303992251, 6415.582987105823, 6147.600405973598, 6177.536684748572, 6248.968755156195, 6250.156228909039, 6250.781222657367, 6241.469475094668, 6380.170577824853, 6385.680715964276, 6397.776077837253, 6404.93595064062, 6170.691465426621, 6254.155688982111, 6259.687015649109, 6264.185655864709, 6269.279032911274, 6112.419320164578, 6138.447539721446, 6229.626222426669, 6244.406781355764, 6252.437280644764, 5529.834104976857, 5948.315943666534, 6127.448529632355, 6167.506599472121, 6224.62652240867, 4447.977760111308, 4475.977620111878, 4989.675671081368, 5090.662125653585, 6177.042558403455, 5706.629069110494, 5964.165016897551, 6082.118092876596, 6096.969515152396, 6120.510359171345, 6016.639001659914, 6074.271087469532, 6139.293981192041, 6187.412195841388, 6223.688815559294, 4613.700109492872, 5198.766055527435, 5432.103702888979, 6090.665013424305, 6157.076438534255], "unit": "score", "name": "dojo.html", "value": 5639.029289698533}, {"lowerIsBetter": false, "replicates": [476.2998392363226, 478.2873518457497, 524.0017766155473, 558.7457706743432, 572.3932631410703, 30907.0, 36754.632453675455, 36857.815710921444, 37053.81473092637, 37110.62889371102, 38096.61903380966, 38179.0, 38558.0, 38580.0, 38618.22763544727, 9366.765830854249, 9564.80870382592, 9565.713028609118, 9582.856257156149, 9617.903820961807, 9466.574004169794, 9589.520523973808, 9723.27075469339, 9767.951160244189, 9790.265730070238, 9699.806003879918, 9739.464329461876, 9797.26520510961, 9803.852942205873, 9820.656277030306, 9709.41743495389, 9745.805083898318, 9767.853482197772, 9772.706818795448, 9789.36369136011, 9523.142917137491, 9623.56693948774, 9632.036796320383, 9634.662786802499, 9681.806363872684, 37576.24847503035, 37701.0, 37931.43102853459, 37993.81003094994, 38014.23971520554, 3112.190074421931, 3219.3561287742546, 3225.516172574109, 3226.1934516370907, 3229.1765599771907, 28368.716312836816, 28511.0, 28616.713832861613, 29039.12882613525, 29177.854110729524, 2725.0, 2726.3456770375165, 2782.1792571191545, 2949.1889730324333, 2974.5389464633017, 490012.5499372516, 492366.0, 495249.0, 496885.0, 497194.0, 44599.55400445954, 45083.09833803306, 53321.0, 66016.33983660198, 66249.35002599841, 33464.0, 36223.27553448916, 40846.9788255296, 43789.0, 43822.561774382484, 15123.848761512465, 15375.461858835111, 15439.305231264396, 15506.84493155054, 15530.84469155294, 10142.594296228068, 12336.383180840921, 12381.566645167375, 12396.81404778929, 12553.686157846127, 14240.074395164282, 14253.287335633177, 14457.421703131968, 14461.421543138367, 14600.780988285183, 6313.9368606314265, 6416.839579010562, 6435.581687190412, 6462.806115816439, 6471.708773105222, 921.2675922641516, 984.0, 1081.9829360401197, 1102.1458369763498, 1107.1143085531542, 30026.84986575097, 30544.54183187254, 30994.535081973787, 31067.84466077655, 31433.37133257368, 1057.4501259345097, 1061.8088744025995, 1092.153580974735, 1141.57191053355, 1162.0877611075266, 12719.809202861965, 13400.731985360238, 14203.715925681428, 14474.710505790035, 14488.91333150018, 615819.0, 629042.0, 633519.0, 637849.0, 638125.0, 58343.0, 58782.70608646929, 59282.40717592769, 59411.40588594145, 59429.0, 1238.4984081447028, 1417.3834382043844, 1429.199648197013, 1433.4481224728554, 1571.6856628674311, 30113.548296776004, 30306.090817275515, 30444.0, 30682.079537613907, 30934.0719778407, 49075.0, 49319.013619728124, 49544.75227623839, 49584.0, 49840.75079624579, 495158.0, 498410.0, 498808.0, 498972.0, 499723.0027699822, 31413.743450261733, 32059.839700801345, 32502.349953000336, 32579.18552036218, 32912.0, 42472.57527424686, 42707.3593896098, 43164.568354316056, 43547.56452435562, 43914.341284880116, 35324.82337588296, 36510.90467285879, 36549.26901462009, 36777.81611091927, 37009.62990370062, 34964.300713986086, 35326.11684707903, 35880.92357229287, 35906.92279231627, 36151.81924090363, 29846.701532984393, 34907.0, 35414.64585354216, 35949.1012724684, 36326.455103174005, 30558.777648893796, 32143.678563214067, 32276.83861580771, 32464.02607921766, 32617.836910815295, 23999.52000959936, 24352.756472435758, 24514.50970980535, 25559.872200638878, 25565.23304300874], "unit": "score", "name": "ext.html", "value": 18989.23773338199}, {"lowerIsBetter": false, "replicates": [286.9870855811489, 365.37703216016695, 369.11044383036887, 369.2006805266597, 375.56059410489723, 15243.466478673248, 18744.625107497843, 19038.42884713457, 19727.01364931755, 20622.072006759696, 11615.303081815096, 12060.914517693405, 12066.879331206706, 19124.904375478138, 19443.70834437481, 5167.328247327851, 5272.051030814452, 5281.603879709018, 5339.5728341732565, 5342.893142137155, 5052.473763118441, 5243.056249875021, 5274.024305503475, 5280.1815718563685, 5286.233496143057, 5215.269862219292, 5243.239730239113, 5609.719514024303, 5850.853728656796, 5858.297004359483, 5511.118221084647, 5731.111677689964, 5732.140178973145, 5775.0, 5804.448577385163, 4631.907361852744, 5487.204355368449, 5537.141743029837, 5561.416051314594, 5575.163725441216, 12897.0, 20459.0, 23528.882355588114, 23645.527089458286, 23740.05039798406, 1856.9164387602455, 2128.7977642123974, 2137.1237792505153, 2296.8047715944167, 2311.7457079721216, 8100.635471403801, 9584.712458626253, 9730.562124704406, 9904.801903961952, 9918.851217231748, 1661.858742006931, 1688.3837399349272, 1709.265016043101, 1731.8354756298131, 1798.2357498063402, 106113.0, 109420.4528977358, 109705.90294097037, 111511.0, 111667.0, 9465.763355916019, 9874.901250987541, 10237.0, 11024.173187011007, 11300.15248856339, 12071.879281207252, 13056.869431305566, 13547.59357219285, 13763.587092387244, 13772.655683607789, 8302.83394332122, 8452.112528184452, 8554.914450855536, 8569.571521424028, 8579.270761985177, 8614.44006139599, 8630.6979255727, 8652.697155599524, 8695.695650652324, 8724.651013959498, 4371.628411584988, 4411.117776444724, 4462.9107417851465, 4463.598276155161, 4500.167469018176, 1861.5346163459135, 1907.122723547156, 1918.6834172361682, 1920.7983161767813, 1930.3533316339183, 884.2218847414234, 938.2822141062093, 943.4197469919764, 966.5891995901713, 1064.9680509584725, 16979.15104244783, 20542.79457205409, 21239.362819115453, 21445.0, 21524.784752152278, 913.3743385780762, 947.0907928388687, 949.2500924269888, 968.1431932739576, 987.7283746969497, 8792.8681069784, 11101.38942358178, 11117.666470005914, 11188.720281993015, 11191.216614836883, 613773.0, 614968.0, 621372.0, 633927.0, 637509.0, 99021.0, 111024.22439439078, 123077.0, 129408.70591294154, 129423.0, 1053.3258714422775, 1064.8668916385607, 1073.7959787640323, 1080.4057768227444, 1090.4275255490932, 13255.80116298237, 18624.720629190844, 18672.439826805217, 18961.336353227573, 19202.8079719201, 42829.0, 48272.0, 49644.50355496399, 51194.48805511897, 55827.16259256033, 66775.33224667885, 76855.46289074299, 77154.84267736101, 77439.2256077432, 79175.60412197902, 8031.714925611874, 8248.958755206426, 8330.208630180123, 8340.41617086798, 8382.58087095655, 9879.357841740264, 12804.871951280367, 13597.932010339884, 13601.183928964294, 13727.656808579866, 11215.943920280346, 11321.660350189508, 11465.0, 11534.480948357177, 11621.95402413753, 11450.942745286553, 11561.190716649753, 11564.323173140016, 11830.994365479031, 11928.582499612472, 11282.266652667551, 11729.0, 11956.282623042645, 11964.760704785682, 11973.521059157536, 6608.669566521751, 8192.016957965083, 8221.424500284922, 8241.464304820167, 8312.085670576353, 9911.55398007077, 10400.427976461368, 10905.400202988912, 11500.309981401142, 11822.349770762346], "unit": "score", "name": "jquery.html", "value": 9186.56888850156}, {"lowerIsBetter": false, "replicates": [1557.8597926186642, 1570.6151992761775, 1640.983590164098, 1805.882617629854, 1921.356345624216, 7890.0, 8566.657333706644, 8826.514541700211, 8846.778830529232, 8855.0, 8751.474911505298, 8773.649054037847, 8829.602667879944, 8885.955570222157, 8897.466152030882, 2111.6515774897125, 2471.0486462711806, 2471.1721573272885, 2498.912538061168, 2502.862342571158, 2061.494933741228, 2477.306354220812, 2488.7511248875057, 2514.220591616605, 2521.1932181701864, 2442.5969714997004, 2497.5878979968284, 2506.7117281512587, 2512.6984761828517, 2521.067205134103, 2493.5885578879374, 2498.375406148463, 2505.348609361561, 2515.1071369663687, 2533.4173140177772, 2530.0132948150235, 2552.2853600991753, 2553.080890879282, 2559.142687199772, 2560.142352311978, 8826.735197944072, 8855.07021762712, 8889.511076890769, 8911.287097032222, 8951.955240223822, 5338.27933229013, 5433.8369848904595, 5485.917711234295, 5501.339839219319, 5508.20131080995, 3613.8554457821656, 3699.7780133192095, 3746.7002639788752, 3761.6238376162437, 3769.0577355661085, 1035.0322448510667, 1043.5929987304958, 1050.5272627317738, 1085.4301491716833, 1085.630885498934, 12198.451069701796, 12247.0, 12253.816192757116, 12354.888060074636, 12382.938085309515, 4195.056112374752, 4335.674824388184, 4804.06320767454, 4838.758062096881, 4861.975690121598, 9333.813323733622, 9472.384295020802, 9536.28477864163, 9537.61849526025, 9549.952250238704, 4666.953330466652, 5336.332958380202, 5440.238366628675, 5485.424030476823, 5506.669599824023, 4471.530489298641, 4872.975635121802, 4964.429090654548, 4990.800367985313, 5080.847574572768, 3815.751976121543, 3821.331267028259, 3859.864904728321, 3876.302265592164, 3876.4185372193833, 1164.6855349055706, 1186.3593659423814, 1188.5483516263937, 1201.0631707268344, 1201.9519219231133, 1064.5848119233506, 1071.689210129054, 1081.4700796609604, 1222.9082818788627, 1374.731927274192, 8126.431149819574, 8197.877031844528, 8221.79445513867, 8271.627776750061, 8379.581020948928, 463.6036189058374, 488.61155381471104, 507.82733870483474, 512.2648998686897, 514.9794008239703, 6160.537959653044, 6218.347073557302, 6222.533310001768, 6274.843128921813, 6283.874322513524, 10494.632687855888, 10799.514021869034, 10824.296420732784, 10842.94578527118, 11102.888971110347, 10424.947875260576, 10503.107235885036, 10647.520861561248, 10775.461226938622, 10783.299085559414, 8220.588970551567, 8250.133735957637, 8383.0, 8410.873836892451, 8452.57737113142, 8066.637001335072, 8072.313853322534, 8123.0, 8145.266925976691, 8268.0, 9548.140667339972, 9753.12221900004, 9799.971003044579, 9829.361091529028, 9879.851802223116, 9770.267229957639, 10071.34536255141, 10119.190464762949, 10127.088562029452, 10238.744031399274, 6637.966810165918, 7437.181909990005, 7465.813354665959, 7498.737544185928, 7629.809254768676, 8134.593270336578, 8176.46852954556, 8196.67213311461, 8261.876071859047, 8272.214139656722, 5937.91093133612, 6020.4280593343565, 6530.183727034121, 6940.0, 7448.1807001228735, 6043.758249669964, 6198.566100372931, 7229.421646268391, 7311.122665280201, 7342.926570734225, 6190.2571691397325, 7807.726729564665, 7825.726099586487, 7835.098963619257, 7896.7236146734585, 7022.367986881205, 7055.2591977841585, 7060.8940865886025, 7082.964585177041, 7116.750913717995, 7093.255208203064, 7148.606826624586, 7161.4986950912935, 7191.748288809867, 7216.3505284524645], "unit": "score", "name": "mootools.html", "value": 4802.236949180515}, {"lowerIsBetter": false, "replicates": [317.32093320294575, 323.12916689521734, 326.37499189052966, 333.74968773419926, 334.3480213583513, 5516.558675305981, 6129.957907155783, 6576.0135979602965, 6640.236372817128, 6670.266270710218, 6711.0, 6714.362135597123, 6751.898721519181, 6766.7631632892735, 6781.287964763703, 4993.054098082131, 4994.300797888281, 5013.997200559885, 5019.272205530205, 5023.095842748304, 4997.675151115184, 5017.147084995541, 5019.52314530119, 5024.874378140539, 5044.092063428581, 4945.7774400152075, 4961.355023846912, 4962.206047032476, 4972.726500042496, 4976.676516026447, 4726.338312636233, 4893.8776530586665, 4966.255061740731, 4971.45314015458, 4984.728894131991, 4083.693722970759, 4126.00975765817, 4128.1330920506725, 4137.110521237948, 4142.79286035697, 6351.269603995507, 6354.332795056545, 6359.17330747, 6366.808995730135, 6369.426751592379, 5490.533304669068, 5618.775248990036, 5626.831195064155, 5633.718314084279, 5641.0, 7074.327938845801, 7080.433565314814, 7086.503944723871, 7089.093471676588, 7096.183938847047, 4526.569975852289, 4556.635469162459, 4564.566366195206, 4580.656450766206, 4612.1698094343, 5558.471945165203, 6170.96914515429, 7377.815554611124, 7402.407807375397, 7569.0, 3790.3177428062663, 4503.279475283939, 4545.38637283969, 4598.195315819718, 4624.838130665411, 3803.8858834235016, 4677.95322046782, 4684.929726054112, 4701.64737644678, 4708.482066972699, 5615.719214039282, 5649.4915457608195, 5675.971620141955, 5679.829605111853, 5713.800016999385, 5834.620749651259, 7160.140783106061, 7190.496665233383, 7199.856002879913, 7217.675204615805, 1623.9675206495804, 1644.7203975324223, 1645.1856331116173, 1645.5556999610037, 1656.097426902341, 1019.0421004255976, 1051.847482115089, 1058.7988282226506, 1061.6708820265742, 1068.893110688925, 6429.903551446732, 6716.194056713226, 6802.183737951378, 6813.420859226922, 6817.488688348394, 7229.385502232264, 7483.962580187064, 7505.324520793155, 7505.437092218105, 7506.28690274423, 6774.559653622498, 6780.016897549827, 6788.0, 6796.864062718718, 6842.965785171043, 3802.239552089593, 3934.232824599233, 3947.1710940702774, 3965.72239943207, 3967.3255546557157, 7812.414068944852, 7856.5678887661725, 7869.095054068741, 7878.527288362602, 7925.722599708983, 5689.857753556194, 6070.694800617888, 6574.276829548746, 6983.825404364931, 7721.65252563636, 6265.279492858289, 6683.899741503881, 6714.899276510759, 7842.607869606497, 7850.136484986761, 7206.0, 7430.071241094864, 7432.368248698921, 7463.141738700119, 7496.389720322071, 7264.745733899288, 7320.15818180916, 7326.780196594111, 7330.193678695446, 7358.889616655862, 7795.805104872424, 7801.414893882868, 7811.687532498637, 7837.098733645704, 7849.646765895434, 4654.883627909329, 4657.930131048105, 4665.300204969281, 4667.743274119956, 4671.9299210512545, 6844.035065178823, 7121.252268511939, 7370.852582948418, 7407.185209627044, 7431.851362972819, 5896.0, 7150.5352152109945, 7180.281971802778, 7216.134063912364, 7228.566286022856, 7207.882778169392, 7216.314450127229, 7217.953396757546, 7219.422446204396, 7253.56478611285, 7034.0, 7037.1555413350725, 7042.436605071684, 7045.401140903081, 7069.22238553769, 6933.341332573397, 7164.283571642794, 7185.065941427581, 7219.6751146199595, 7252.0, 5714.228579141763, 7019.684114214975, 7031.226565077735, 7061.682224299816, 7084.858302833812], "unit": "score", "name": "prototype.html", "value": 5159.019757315451}, {"lowerIsBetter": false, "replicates": [661.4509956735913, 709.9609521476317, 712.7042277454857, 734.9559026458412, 737.7676032049903, 14735.0, 15077.321520531576, 15085.094894306349, 17059.658806823856, 17278.654426911453, 15852.365905363771, 15865.04809711418, 15903.761443578356, 15993.84006159938, 15996.76004859928, 686.1217641418991, 856.0668870930684, 865.5628907401754, 883.9602217900177, 894.575076838503, 858.9055203927563, 879.7844528090595, 883.5361435246515, 884.7920738626418, 885.1369914333505, 920.2086205862953, 924.6902287733617, 924.7087167542236, 927.3554879358815, 927.5037854747677, 897.7217062710548, 899.2491269789733, 913.634546181526, 918.6095909238547, 920.3879420185568, 670.7451168555966, 678.396227357652, 681.4207923265235, 685.1777866560147, 685.3283781893722, 15248.466303679428, 15271.083734975826, 15314.463993760164, 15367.846321536754, 15420.768688469681, 12617.621471355875, 12722.0, 12814.103012789108, 13106.541271055563, 13189.392161464457, 10101.595936162617, 10240.180785537139, 10377.0, 10674.146068314516, 10934.835977460345, 3444.810535420551, 3503.91240218994, 3504.5093686883856, 3504.7721898076543, 3518.542589463379, 77717.0, 79213.81179282258, 79517.60241198757, 80192.59903700445, 83205.0, 9315.394499357655, 9340.673076442292, 9387.249020078378, 9553.04469553053, 9649.083337082966, 20163.495912602008, 20337.0, 20357.389278321672, 20361.287354942506, 20363.8981805093, 7354.96322518384, 7527.8494430111095, 7651.502652327581, 7833.373330133576, 8007.119216886138, 4034.45534852797, 4060.939085913714, 4079.6736261099636, 4082.510098788105, 4086.6730661547003, 3568.7323450741296, 3593.3531964246163, 3598.838052287653, 3630.8184590770884, 3630.945535816912, 616.2481772237952, 633.2432742872223, 638.2213699286863, 665.1917919727555, 691.4502970138752, 555.4390066033335, 606.8088552106072, 621.0745988477137, 629.3571354354738, 630.0391902348863, 8549.316054715608, 8670.26302764272, 8720.8691869622, 8834.160754728291, 8880.756694062837, 507.9822206222838, 544.3957207499673, 624.8250489862845, 627.3538255596743, 647.7894684227645, 3842.558105817811, 4077.918441631151, 4083.6528895044253, 4104.856330028435, 4182.2681030820095, 95078.0, 95784.0, 96657.0, 98080.66314363216, 98431.0, 62268.44328891723, 82961.0, 83092.0, 83971.16028839634, 85315.72026419609, 52929.735351323, 71981.64009180025, 72616.0, 73453.53092938218, 73632.26367736362, 8758.0, 8851.778705532413, 8981.191692747423, 8985.730428087169, 9135.908640913505, 48607.75696121497, 51272.74363628158, 52512.21231681451, 52966.735166323924, 53086.0, 50761.74619126881, 71478.49825256299, 71915.64042179755, 72542.0, 73854.0, 7527.865331649569, 11088.667339979813, 11098.667039988813, 11214.102871770076, 11420.71448213768, 10200.0, 12425.502979880703, 12453.688657783629, 12484.625461236177, 12953.0, 11532.94233528827, 11735.354555499529, 11895.643130706092, 11948.880511194777, 12058.698532536757, 10688.305260158066, 11356.091512679131, 11515.963563279345, 12095.455704493495, 12368.257904525757, 10950.56197752081, 11702.903983605669, 11786.469608867794, 11915.463804128662, 12231.633051008484, 9186.954065229631, 9347.579358928728, 9470.905290947278, 9896.10935015852, 10124.341917775615, 8627.137286271323, 8833.29333653319, 9294.535273236446, 9603.371491765627, 10077.949610251902], "unit": "score", "name": "yui.html", "value": 6979.993664988096}], "name": "dromaeo_css", "value": 7443.790794813504}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [154.0, 95.0, 153.0, 94.0, 165.0, 113.0, 149.0, 96.0, 110.0, 158.0], "unit": "score", "name": "ai-astar", "value": 128.7}, {"lowerIsBetter": true, "replicates": [159.0, 151.0, 151.0, 151.0, 144.0, 130.0, 173.0, 160.0, 163.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [190.0, 199.0, 204.0, 228.0, 197.0, 201.0, 195.0, 192.0, 239.0, 185.0], "unit": "score", "name": "audio-dft", "value": 203.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 134.0, 85.0, 85.0, 68.0, 60.0, 83.0, 57.0], "unit": "score", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 142.0, 93.0, 82.0, 80.0, 114.0, 81.0, 81.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 96.3}, {"lowerIsBetter": true, "replicates": [86.0, 93.0, 86.0, 95.0, 91.0, 91.0, 86.0, 92.0, 129.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.6}, {"lowerIsBetter": true, "replicates": [95.0, 102.0, 97.0, 97.0, 96.0, 97.0, 95.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 96.8}, {"lowerIsBetter": true, "replicates": [91.0, 79.0, 125.0, 146.0, 139.0, 90.0, 91.0, 92.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 103.6}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 58.0, 59.0, 76.0, 87.0, 87.0], "unit": "score", "name": "json-parse-financial", "value": 65.1}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 72.0, 74.0, 77.0, 74.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 85.0, 85.0, 85.0, 85.0, 84.0, 86.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [136.0, 137.0, 139.0, 126.0, 126.0, 152.0, 144.0, 126.0, 131.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.8}, {"lowerIsBetter": true, "replicates": [139.0, 144.0, 140.0, 143.0, 145.0, 142.0, 142.0, 158.0, 145.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 85.0, 64.0, 64.0, 70.0, 104.0, 97.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.8}], "name": "kraken", "value": 1528.6}]} 10:37:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1528.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7443.79"}}} 10:37:40 INFO - Return code: 0 10:37:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:37:40 ERROR - # TBPL SUCCESS # 10:37:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:37:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:37:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:37:40 INFO - 2016-02-23 10:37:40.596 screenresolution[2092:17364] starting screenresolution argv=screenresolution get 10:37:40 INFO - 2016-02-23 10:37:40.599 screenresolution[2092:17364] Display 0: 1600x1200x32@60 10:37:40 INFO - 2016-02-23 10:37:40.605 screenresolution[2093:17367] starting screenresolution argv=screenresolution list 10:37:40 INFO - Available Modes on Display 0 10:37:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:37:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:37:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:37:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:37:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:37:40 INFO - Intel Iris: 10:37:40 INFO - Chipset Model: Intel Iris 10:37:40 INFO - Type: GPU 10:37:40 INFO - Bus: Built-In 10:37:40 INFO - VRAM (Dynamic, Max): 1536 MB 10:37:40 INFO - Vendor: Intel (0x8086) 10:37:40 INFO - Device ID: 0x0a2e 10:37:40 INFO - Revision ID: 0x0009 10:37:40 INFO - Displays: 10:37:40 INFO - Display: 10:37:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:37:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:37:40 INFO - Display Serial Number: 1600x1200 60 10:37:40 INFO - Main Display: Yes 10:37:40 INFO - Mirror: Off 10:37:40 INFO - Online: Yes 10:37:40 INFO - Rotation: Supported 10:37:40 INFO - Return code: 0 10:37:40 INFO - Running post-action listener: _resource_record_post_action 10:37:40 INFO - Running post-run listener: _resource_record_post_run 10:37:41 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 1696256; Write bytes: 712771584; Read time: 18; Write time: 3049 10:37:41 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394973696; Write bytes: 390100480; Read time: 29870; Write time: 762 10:37:41 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 1696256; Write bytes: 304767488; Read time: 18; Write time: 2246 10:37:41 INFO - Running post-run listener: _upload_blobber_files 10:37:41 INFO - Blob upload gear active. 10:37:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:37:41 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 10:37:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:37:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:37:42 INFO - (blobuploader) - INFO - Open directory for files ... 10:37:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:37:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:37:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:43 INFO - (blobuploader) - INFO - Done attempting. 10:37:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:37:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:37:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:44 INFO - (blobuploader) - INFO - Done attempting. 10:37:44 INFO - (blobuploader) - INFO - Iteration through files over. 10:37:44 INFO - Return code: 0 10:37:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:37:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:37:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/978748de6275ac6b1056fef080923656643ad65570ba9c433ad0e4de41fdd3510dda6423fbf16c43818969b11af8342be49e6bd41fc2602ca6c028876ad81dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d88a7a5df5404f912c226f00b0a927ee810c0fc7d937481931365bcd49122436745a4d295cdee43a6c088f16dfe7af7383ca058d9f907aaaad147e53006129c"} 10:37:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:37:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:37:44 INFO - Contents: 10:37:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/978748de6275ac6b1056fef080923656643ad65570ba9c433ad0e4de41fdd3510dda6423fbf16c43818969b11af8342be49e6bd41fc2602ca6c028876ad81dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d88a7a5df5404f912c226f00b0a927ee810c0fc7d937481931365bcd49122436745a4d295cdee43a6c088f16dfe7af7383ca058d9f907aaaad147e53006129c"} 10:37:44 INFO - Running post-run listener: copy_logs_to_upload_dir 10:37:44 INFO - Copying logs to upload dir... 10:37:44 INFO - mkdir: /builds/slave/test/build/upload/logs 10:37:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.146705 ========= master_lag: 13.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-02-23 10:37:57.482624) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 22 secs) (at 2016-02-23 10:37:57.486096) ========= 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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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/Firefox/sha512/978748de6275ac6b1056fef080923656643ad65570ba9c433ad0e4de41fdd3510dda6423fbf16c43818969b11af8342be49e6bd41fc2602ca6c028876ad81dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d88a7a5df5404f912c226f00b0a927ee810c0fc7d937481931365bcd49122436745a4d295cdee43a6c088f16dfe7af7383ca058d9f907aaaad147e53006129c"} build_url:https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/978748de6275ac6b1056fef080923656643ad65570ba9c433ad0e4de41fdd3510dda6423fbf16c43818969b11af8342be49e6bd41fc2602ca6c028876ad81dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d88a7a5df5404f912c226f00b0a927ee810c0fc7d937481931365bcd49122436745a4d295cdee43a6c088f16dfe7af7383ca058d9f907aaaad147e53006129c"}' ========= master_lag: 22.57 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 22 secs) (at 2016-02-23 10:38:20.066929) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 20 secs) (at 2016-02-23 10:38:20.067262) ========= 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.NDeQsJuXHN/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.q2YHf5K1hL/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005670 ========= master_lag: 20.95 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 20 secs) (at 2016-02-23 10:38:41.023456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:38:41.023858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:38:41.917737) ========= ========= Total master_lag: 57.07 =========