builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0078 starttime: 1455142816.82 results: success (0) buildid: 20160210122822 builduid: 22d7898bb06b4159894b5330e0069514 revision: 745c98ace7f0a3420f9b2079ece59064e5a33196 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.817867) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.818346) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.818663) ========= 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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005688 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.842371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.842691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.858812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.859184) ========= 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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005520 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.908644) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.908968) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.909920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:16.910226) ========= 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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-10 14:20:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.9M=0s 2016-02-10 14:20:17 (44.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:17.069389) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:17.069778) ========= 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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.027065 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:17.118997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:17.119943) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 745c98ace7f0a3420f9b2079ece59064e5a33196 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 745c98ace7f0a3420f9b2079ece59064e5a33196 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-10 14:20:17,193 truncating revision to first 12 chars 2016-02-10 14:20:17,193 Setting DEBUG logging. 2016-02-10 14:20:17,193 attempt 1/10 2016-02-10 14:20:17,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/745c98ace7f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 14:20:17,817 unpacking tar archive at: fx-team-745c98ace7f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.868552 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:18.004710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:18.005216) ========= echo 745c98ace7f0a3420f9b2079ece59064e5a33196 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'745c98ace7f0a3420f9b2079ece59064e5a33196'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 745c98ace7f0a3420f9b2079ece59064e5a33196 program finished with exit code 0 elapsedTime=0.005568 script_repo_revision: '745c98ace7f0a3420f9b2079ece59064e5a33196' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:18.055677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:18.056069) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 14:20:18.069024) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-10 14:20:18.069423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:20:18 INFO - MultiFileLogger online at 20160210 14:20:18 in /builds/slave/test 14:20:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:20:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:20:18 INFO - {'append_to_log': False, 14:20:18 INFO - 'base_work_dir': '/builds/slave/test', 14:20:18 INFO - 'blob_upload_branch': 'Fx-Team', 14:20:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:20:18 INFO - 'branch': 'Fx-Team', 14:20:18 INFO - 'buildbot_json_path': 'buildprops.json', 14:20:18 INFO - 'config_files': ('talos/mac_config.py',), 14:20:18 INFO - 'default_actions': ('clobber', 14:20:18 INFO - 'read-buildbot-config', 14:20:18 INFO - 'download-and-extract', 14:20:18 INFO - 'populate-webroot', 14:20:18 INFO - 'create-virtualenv', 14:20:18 INFO - 'install', 14:20:18 INFO - 'run-tests'), 14:20:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:20:18 INFO - 'download_minidump_stackwalk': True, 14:20:18 INFO - 'download_symbols': 'ondemand', 14:20:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:20:18 INFO - 'tooltool.py': '/tools/tooltool.py', 14:20:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:20:18 INFO - '/tools/misc-python/virtualenv.py')}, 14:20:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:20:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:20:18 INFO - 'installer_path': 'installer.exe', 14:20:18 INFO - 'log_level': 'info', 14:20:18 INFO - 'log_name': 'talos', 14:20:18 INFO - 'log_to_console': True, 14:20:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:20:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:20:18 INFO - 'opt_config_files': (), 14:20:18 INFO - 'pip_index': False, 14:20:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:20:18 INFO - 'cmd': ('bash', 14:20:18 INFO - '-c', 14:20:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:20:18 INFO - 'enabled': True, 14:20:18 INFO - 'halt_on_failure': False, 14:20:18 INFO - 'name': 'check_screen_resolution'},), 14:20:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:20:18 INFO - 'cmd': ('bash', 14:20:18 INFO - '-c', 14:20:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:20:18 INFO - 'enabled': True, 14:20:18 INFO - 'halt_on_failure': False, 14:20:18 INFO - 'name': 'check_screen_resolution'},), 14:20:18 INFO - 'run_cmd_checks_enabled': True, 14:20:18 INFO - 'sps_profile': False, 14:20:18 INFO - 'sps_profile_interval': 0, 14:20:18 INFO - 'suite': 'dromaeojs', 14:20:18 INFO - 'system_bits': '32', 14:20:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:20:18 INFO - 'title': 't-yosemite-r7-0078', 14:20:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:20:18 INFO - 'use_talos_json': True, 14:20:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:20:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:20:18 INFO - 'work_dir': 'build'} 14:20:18 INFO - ##### 14:20:18 INFO - ##### Running clobber step. 14:20:18 INFO - ##### 14:20:18 INFO - Running pre-action listener: _resource_record_pre_action 14:20:18 INFO - Running main action method: clobber 14:20:18 INFO - rmtree: /builds/slave/test/build 14:20:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:20:19 INFO - Running post-action listener: _resource_record_post_action 14:20:19 INFO - ##### 14:20:19 INFO - ##### Running read-buildbot-config step. 14:20:19 INFO - ##### 14:20:19 INFO - Running pre-action listener: _resource_record_pre_action 14:20:19 INFO - Running main action method: read_buildbot_config 14:20:19 INFO - Using buildbot properties: 14:20:19 INFO - { 14:20:19 INFO - "project": "", 14:20:19 INFO - "product": "firefox", 14:20:19 INFO - "script_repo_revision": "production", 14:20:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:20:19 INFO - "repository": "", 14:20:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:20:19 INFO - "buildid": "20160210122822", 14:20:19 INFO - "pgo_build": "False", 14:20:19 INFO - "basedir": "/builds/slave/test", 14:20:19 INFO - "buildnumber": 324, 14:20:19 INFO - "slavename": "t-yosemite-r7-0078", 14:20:19 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:20:19 INFO - "platform": "yosemite_r7", 14:20:19 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:20:19 INFO - "branch": "fx-team", 14:20:19 INFO - "repo_path": "integration/fx-team", 14:20:19 INFO - "revision": "745c98ace7f0a3420f9b2079ece59064e5a33196", 14:20:19 INFO - "stage_platform": "macosx64", 14:20:19 INFO - "builduid": "22d7898bb06b4159894b5330e0069514", 14:20:19 INFO - "slavebuilddir": "test" 14:20:19 INFO - } 14:20:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:20:19 INFO - Running post-action listener: _resource_record_post_action 14:20:19 INFO - ##### 14:20:19 INFO - ##### Running download-and-extract step. 14:20:19 INFO - ##### 14:20:19 INFO - Running pre-action listener: _resource_record_pre_action 14:20:19 INFO - Running main action method: download_and_extract 14:20:19 INFO - mkdir: /builds/slave/test/build/tests 14:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:19 INFO - https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:20:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/test_packages.json 14:20:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/test_packages.json 14:20:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:20:21 INFO - Downloaded 1277 bytes. 14:20:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:20:21 INFO - Using the following test package requirements: 14:20:21 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:20:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:20:21 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:20:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:20:21 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:20:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:20:21 INFO - u'jsshell-mac.zip'], 14:20:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:20:21 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:20:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:20:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:20:21 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:20:21 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:20:21 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:20:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:20:21 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:20:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:20:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:20:21 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:20:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:21 INFO - https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:20:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:20:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:20:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:20:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:20:22 INFO - Downloaded 17750524 bytes. 14:20:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:20:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:20:25 INFO - Return code: 0 14:20:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:20: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')]} 14:20:25 INFO - https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:20:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:20:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:20:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:20:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:20:26 INFO - Downloaded 17750524 bytes. 14:20:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:20:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:20:29 INFO - Return code: 0 14:20: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')]} 14:20:29 INFO - https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:20:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:20:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:20:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:20:30 INFO - Downloaded 10706547 bytes. 14:20:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:20:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:20:30 INFO - Return code: 0 14:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:30 INFO - https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:20:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:20:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:20:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 14:20:33 INFO - Downloaded 111186869 bytes. 14:20:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:20:33 INFO - mkdir: /builds/slave/test/properties 14:20:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:20:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:20:33 INFO - Contents: 14:20:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:20:34 INFO - Running post-action listener: _resource_record_post_action 14:20:34 INFO - Running post-action listener: set_extra_try_arguments 14:20:34 INFO - ##### 14:20:34 INFO - ##### Running populate-webroot step. 14:20:34 INFO - ##### 14:20:34 INFO - Running pre-action listener: _resource_record_pre_action 14:20:34 INFO - Running main action method: populate_webroot 14:20:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:20:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:20:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:20:34 INFO - '--tppagecycles', 14:20:34 INFO - '7'], 14:20:34 INFO - 'tests': ['tsvgm']}}, 14:20:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:20:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:20:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:20:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:20:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:20:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:34 INFO - 'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:20:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:34 INFO - 'tests': ['damp', 'tps']}, 14:20:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:34 INFO - 'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['damp', 'tps']}, 14:20:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:20:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:20:34 INFO - 'other': {'tests': ['a11yr', 14:20:34 INFO - 'ts_paint', 14:20:34 INFO - 'tpaint', 14:20:34 INFO - 'sessionrestore', 14:20:34 INFO - 'sessionrestore_no_auto_restore']}, 14:20:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['a11yr', 14:20:34 INFO - 'ts_paint', 14:20:34 INFO - 'tpaint', 14:20:34 INFO - 'sessionrestore', 14:20:34 INFO - 'sessionrestore_no_auto_restore']}, 14:20:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['a11yr', 14:20:34 INFO - 'ts_paint', 14:20:34 INFO - 'tpaint', 14:20:34 INFO - 'sessionrestore', 14:20:34 INFO - 'sessionrestore_no_auto_restore']}, 14:20:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['a11yr', 14:20:34 INFO - 'ts_paint', 14:20:34 INFO - 'tpaint', 14:20:34 INFO - 'sessionrestore', 14:20:34 INFO - 'sessionrestore_no_auto_restore']}, 14:20:34 INFO - 'other_l64': {'tests': ['a11yr', 14:20:34 INFO - 'ts_paint', 14:20:34 INFO - 'tpaint', 14:20:34 INFO - 'sessionrestore', 14:20:34 INFO - 'sessionrestore_no_auto_restore']}, 14:20:34 INFO - 'other_nol64': {'tests': ['a11yr', 14:20:34 INFO - 'ts_paint', 14:20:34 INFO - 'tpaint', 14:20:34 INFO - 'sessionrestore', 14:20:34 INFO - 'sessionrestore_no_auto_restore']}, 14:20:34 INFO - 'svgr': {'tests': ['tsvgx', 14:20:34 INFO - 'tsvgr_opacity', 14:20:34 INFO - 'tart', 14:20:34 INFO - 'tscrollx', 14:20:34 INFO - 'cart']}, 14:20:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['tsvgx', 14:20:34 INFO - 'tsvgr_opacity', 14:20:34 INFO - 'tart', 14:20:34 INFO - 'tscrollx', 14:20:34 INFO - 'cart']}, 14:20:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:34 INFO - 'tests': ['tp5o']}, 14:20:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:34 INFO - 'talos_options': ['--e10s'], 14:20:34 INFO - 'tests': ['tp5o']}, 14:20:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:34 INFO - 'talos_options': ['--xperf_path', 14:20:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:20:34 INFO - 'tests': ['tp5n']}, 14:20:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:34 INFO - 'talos_options': ['--e10s', 14:20:34 INFO - '--xperf_path', 14:20:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:20:34 INFO - 'tests': ['tp5n']}}, 14:20:34 INFO - 'talos.zip': {'path': '', 14:20:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:20:34 INFO - Running post-action listener: _resource_record_post_action 14:20:34 INFO - ##### 14:20:34 INFO - ##### Running create-virtualenv step. 14:20:34 INFO - ##### 14:20:34 INFO - Running pre-action listener: _resource_record_pre_action 14:20:34 INFO - Running main action method: create_virtualenv 14:20:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:20:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:20:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:20:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:20:34 INFO - Using real prefix '/tools/python27' 14:20:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:20:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:20:38 INFO - Installing pip.................done. 14:20:38 INFO - Return code: 0 14:20:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:20:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:20:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:38 INFO - 'HOME': '/Users/cltbld', 14:20:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:38 INFO - 'LOGNAME': 'cltbld', 14:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:38 INFO - 'MOZ_NO_REMOTE': '1', 14:20:38 INFO - 'NO_EM_RESTART': '1', 14:20:38 INFO - 'PAGER': '/bin/cat', 14:20:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:38 INFO - 'PWD': '/builds/slave/test', 14:20:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:38 INFO - 'SHELL': '/bin/bash', 14:20:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:20:38 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:20:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:38 INFO - 'USER': 'cltbld', 14:20:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:38 INFO - 'XPC_FLAGS': '0x0', 14:20:38 INFO - 'XPC_SERVICE_NAME': '0', 14:20:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:20:38 INFO - Cleaning up... 14:20:38 INFO - Return code: 0 14:20:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:20:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:20:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:38 INFO - 'HOME': '/Users/cltbld', 14:20:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:38 INFO - 'LOGNAME': 'cltbld', 14:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:38 INFO - 'MOZ_NO_REMOTE': '1', 14:20:38 INFO - 'NO_EM_RESTART': '1', 14:20:38 INFO - 'PAGER': '/bin/cat', 14:20:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:38 INFO - 'PWD': '/builds/slave/test', 14:20:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:38 INFO - 'SHELL': '/bin/bash', 14:20:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:20:38 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:20:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:38 INFO - 'USER': 'cltbld', 14:20:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:38 INFO - 'XPC_FLAGS': '0x0', 14:20:38 INFO - 'XPC_SERVICE_NAME': '0', 14:20:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:38 INFO - Downloading/unpacking psutil>=0.7.1 14:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:20:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:20:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:20:41 INFO - Installing collected packages: psutil 14:20:41 INFO - Running setup.py install for psutil 14:20:41 INFO - building 'psutil._psutil_osx' extension 14:20:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:20:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:20:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:20:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:20:42 INFO - building 'psutil._psutil_posix' extension 14:20:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:20:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:20:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:20:42 INFO - ^ 14:20:42 INFO - 1 warning generated. 14:20:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:20:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:20:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:20:42 INFO - Successfully installed psutil 14:20:42 INFO - Cleaning up... 14:20:42 INFO - Return code: 0 14:20:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:42 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 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:20:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:20:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:20:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:42 INFO - 'HOME': '/Users/cltbld', 14:20:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:42 INFO - 'LOGNAME': 'cltbld', 14:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:42 INFO - 'MOZ_NO_REMOTE': '1', 14:20:42 INFO - 'NO_EM_RESTART': '1', 14:20:42 INFO - 'PAGER': '/bin/cat', 14:20:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:42 INFO - 'PWD': '/builds/slave/test', 14:20:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:42 INFO - 'SHELL': '/bin/bash', 14:20:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:20:42 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:20:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:42 INFO - 'USER': 'cltbld', 14:20:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:42 INFO - 'XPC_FLAGS': '0x0', 14:20:42 INFO - 'XPC_SERVICE_NAME': '0', 14:20:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:20:45 INFO - Installing collected packages: mozsystemmonitor 14:20:45 INFO - Running setup.py install for mozsystemmonitor 14:20:45 INFO - Successfully installed mozsystemmonitor 14:20:45 INFO - Cleaning up... 14:20:45 INFO - Return code: 0 14:20:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:20: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')]} 14:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20: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')]} 14:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:20:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:20:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:45 INFO - 'HOME': '/Users/cltbld', 14:20:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:45 INFO - 'LOGNAME': 'cltbld', 14:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:45 INFO - 'MOZ_NO_REMOTE': '1', 14:20:45 INFO - 'NO_EM_RESTART': '1', 14:20:45 INFO - 'PAGER': '/bin/cat', 14:20:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:45 INFO - 'PWD': '/builds/slave/test', 14:20:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:45 INFO - 'SHELL': '/bin/bash', 14:20:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:20:45 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:20:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:45 INFO - 'USER': 'cltbld', 14:20:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:45 INFO - 'XPC_FLAGS': '0x0', 14:20:45 INFO - 'XPC_SERVICE_NAME': '0', 14:20:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:20:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:20:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:49 INFO - Downloading docopt-0.6.1.tar.gz 14:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:20:49 INFO - Installing collected packages: blobuploader, requests, docopt 14:20:49 INFO - Running setup.py install for blobuploader 14:20:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:20:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:20:49 INFO - Running setup.py install for requests 14:20:50 INFO - Running setup.py install for docopt 14:20:50 INFO - Successfully installed blobuploader requests docopt 14:20:50 INFO - Cleaning up... 14:20:50 INFO - Return code: 0 14:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:50 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 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:20:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:20:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:50 INFO - 'HOME': '/Users/cltbld', 14:20:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:50 INFO - 'LOGNAME': 'cltbld', 14:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:50 INFO - 'MOZ_NO_REMOTE': '1', 14:20:50 INFO - 'NO_EM_RESTART': '1', 14:20:50 INFO - 'PAGER': '/bin/cat', 14:20:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:50 INFO - 'PWD': '/builds/slave/test', 14:20:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:50 INFO - 'SHELL': '/bin/bash', 14:20:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:20:50 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:20:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:50 INFO - 'USER': 'cltbld', 14:20:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:50 INFO - 'XPC_FLAGS': '0x0', 14:20:50 INFO - 'XPC_SERVICE_NAME': '0', 14:20:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:20:50 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-fSY07k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:20:50 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-wcDuNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:20:50 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-s3bXDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:20:50 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-NrJ1oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:20:50 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7S3PEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-pL7IP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-d5ccRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7EflQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-rspILn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-FwZBfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-yRAgrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-md_Cfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-xKKntK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Peuij1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:51 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-YDGrML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:20:52 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-GgBPs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:20:52 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-hAdz5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:20:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:20:52 INFO - Running setup.py install for manifestparser 14:20:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:20:52 INFO - Running setup.py install for mozcrash 14:20:52 INFO - Running setup.py install for mozdebug 14:20:52 INFO - Running setup.py install for mozdevice 14:20:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:20:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:20:52 INFO - Running setup.py install for mozfile 14:20:53 INFO - Running setup.py install for mozhttpd 14:20:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:20:53 INFO - Running setup.py install for mozinfo 14:20:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:20:53 INFO - Running setup.py install for mozInstall 14:20:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:20:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:20:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:20:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:20:53 INFO - Running setup.py install for mozleak 14:20:53 INFO - Running setup.py install for mozlog 14:20:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:20:53 INFO - Running setup.py install for moznetwork 14:20:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:20:53 INFO - Running setup.py install for mozprocess 14:20:54 INFO - Running setup.py install for mozprofile 14:20:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:20:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:20:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:20:54 INFO - Running setup.py install for mozrunner 14:20:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:20:54 INFO - Running setup.py install for mozscreenshot 14:20:54 INFO - Running setup.py install for moztest 14:20:54 INFO - Running setup.py install for mozversion 14:20:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:20:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:20:54 INFO - Cleaning up... 14:20:54 INFO - Return code: 0 14:20:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:54 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 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:20:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:20:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:54 INFO - 'HOME': '/Users/cltbld', 14:20:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:54 INFO - 'LOGNAME': 'cltbld', 14:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:54 INFO - 'MOZ_NO_REMOTE': '1', 14:20:54 INFO - 'NO_EM_RESTART': '1', 14:20:54 INFO - 'PAGER': '/bin/cat', 14:20:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:54 INFO - 'PWD': '/builds/slave/test', 14:20:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:54 INFO - 'SHELL': '/bin/bash', 14:20:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:20:54 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:20:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:54 INFO - 'USER': 'cltbld', 14:20:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:54 INFO - 'XPC_FLAGS': '0x0', 14:20:54 INFO - 'XPC_SERVICE_NAME': '0', 14:20:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-M3dkdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-wHzmNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-6PbLUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-SCsHW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-slOqoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-RDTX6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Mm7z0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ywIdGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:20:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Z57VtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:20:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-KpKzB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:20:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-9WtiDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:20:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-D357ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:20:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-jpzEop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:20:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-9TN_DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-gWbGI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:20:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-huYLvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:20:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-1df8Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:20:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:59 INFO - Downloading blessings-1.6.tar.gz 14:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:20:59 INFO - Installing collected packages: blessings 14:20:59 INFO - Running setup.py install for blessings 14:20:59 INFO - Successfully installed blessings 14:20:59 INFO - Cleaning up... 14:20:59 INFO - Return code: 0 14:20:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:20:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:20:59 INFO - Reading from file tmpfile_stdout 14:20:59 INFO - Current package versions: 14:20:59 INFO - blessings == 1.6 14:20:59 INFO - blobuploader == 1.2.4 14:20:59 INFO - docopt == 0.6.1 14:20:59 INFO - manifestparser == 1.1 14:20:59 INFO - mozInstall == 1.12 14:20:59 INFO - mozcrash == 0.16 14:20:59 INFO - mozdebug == 0.1 14:20:59 INFO - mozdevice == 0.48 14:20:59 INFO - mozfile == 1.2 14:20:59 INFO - mozhttpd == 0.7 14:20:59 INFO - mozinfo == 0.9 14:20:59 INFO - mozleak == 0.1 14:20:59 INFO - mozlog == 3.1 14:20:59 INFO - moznetwork == 0.27 14:20:59 INFO - mozprocess == 0.22 14:20:59 INFO - mozprofile == 0.28 14:20:59 INFO - mozrunner == 6.11 14:20:59 INFO - mozscreenshot == 0.1 14:20:59 INFO - mozsystemmonitor == 0.0 14:20:59 INFO - moztest == 0.7 14:20:59 INFO - mozversion == 1.4 14:20:59 INFO - psutil == 3.1.1 14:20:59 INFO - requests == 1.2.3 14:20:59 INFO - wsgiref == 0.1.2 14:20:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:59 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 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:20:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:20:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:59 INFO - 'HOME': '/Users/cltbld', 14:20:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:59 INFO - 'LOGNAME': 'cltbld', 14:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:59 INFO - 'MOZ_NO_REMOTE': '1', 14:20:59 INFO - 'NO_EM_RESTART': '1', 14:20:59 INFO - 'PAGER': '/bin/cat', 14:20:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:59 INFO - 'PWD': '/builds/slave/test', 14:20:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:59 INFO - 'SHELL': '/bin/bash', 14:20:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:20:59 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:20:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:59 INFO - 'USER': 'cltbld', 14:20:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:59 INFO - 'XPC_FLAGS': '0x0', 14:20:59 INFO - 'XPC_SERVICE_NAME': '0', 14:20:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:21:00 INFO - Cleaning up... 14:21:00 INFO - Return code: 0 14:21:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:00 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 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:00 INFO - 'HOME': '/Users/cltbld', 14:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:00 INFO - 'LOGNAME': 'cltbld', 14:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:00 INFO - 'MOZ_NO_REMOTE': '1', 14:21:00 INFO - 'NO_EM_RESTART': '1', 14:21:00 INFO - 'PAGER': '/bin/cat', 14:21:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:00 INFO - 'PWD': '/builds/slave/test', 14:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:00 INFO - 'SHELL': '/bin/bash', 14:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:21:00 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:00 INFO - 'USER': 'cltbld', 14:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:00 INFO - 'XPC_FLAGS': '0x0', 14:21:00 INFO - 'XPC_SERVICE_NAME': '0', 14:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:00 INFO - Downloading/unpacking jsonschema 14:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:02 INFO - Downloading/unpacking functools32 (from jsonschema) 14:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:03 INFO - warning: no files found matching '*.txt' 14:21:03 INFO - no previously-included directories found matching 'build' 14:21:03 INFO - no previously-included directories found matching 'dist' 14:21:03 INFO - no previously-included directories found matching '.git*' 14:21:03 INFO - Installing collected packages: jsonschema, functools32 14:21:03 INFO - Running setup.py install for functools32 14:21:03 INFO - warning: no files found matching '*.txt' 14:21:03 INFO - no previously-included directories found matching 'build' 14:21:03 INFO - no previously-included directories found matching 'dist' 14:21:03 INFO - no previously-included directories found matching '.git*' 14:21:03 INFO - Successfully installed jsonschema functools32 14:21:03 INFO - Cleaning up... 14:21:03 INFO - Return code: 0 14:21:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce5ad838b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, '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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:03 INFO - 'HOME': '/Users/cltbld', 14:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:03 INFO - 'LOGNAME': 'cltbld', 14:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:03 INFO - 'MOZ_NO_REMOTE': '1', 14:21:03 INFO - 'NO_EM_RESTART': '1', 14:21:03 INFO - 'PAGER': '/bin/cat', 14:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:03 INFO - 'PWD': '/builds/slave/test', 14:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:03 INFO - 'SHELL': '/bin/bash', 14:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:21:03 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:03 INFO - 'USER': 'cltbld', 14:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:03 INFO - 'XPC_FLAGS': '0x0', 14:21:03 INFO - 'XPC_SERVICE_NAME': '0', 14:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:03 INFO - Downloading/unpacking flake8 14:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:21:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:21:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:21:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:21:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:21:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:21:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:21:07 INFO - no previously-included directories found matching 'docs/_build' 14:21:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:21:07 INFO - Running setup.py install for pep8 14:21:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:21:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:21:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:21:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:21:07 INFO - no previously-included directories found matching 'docs/_build' 14:21:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:21:07 INFO - Cleaning up... 14:21:07 INFO - Return code: 0 14:21:07 INFO - Running post-action listener: _resource_record_post_action 14:21:07 INFO - Running post-action listener: _start_resource_monitoring 14:21:07 INFO - Starting resource monitoring. 14:21:07 INFO - ##### 14:21:07 INFO - ##### Running install step. 14:21:07 INFO - ##### 14:21:07 INFO - Running pre-action listener: _resource_record_pre_action 14:21:07 INFO - Running main action method: install 14:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:07 INFO - Reading from file tmpfile_stdout 14:21:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:21:08 INFO - Reading from file tmpfile_stdout 14:21:08 INFO - Output received: 14:21:08 INFO - Usage: mozinstall [options] installer 14:21:08 INFO - Options: 14:21:08 INFO - -h, --help show this help message and exit 14:21:08 INFO - -d DEST, --destination=DEST 14:21:08 INFO - Directory to install application into. [default: 14:21:08 INFO - "/builds/slave/test"] 14:21:08 INFO - --app=APP Application being installed. [default: firefox] 14:21:08 INFO - mkdir: /builds/slave/test/build/application 14:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:21:41 INFO - Reading from file tmpfile_stdout 14:21:41 INFO - Output received: 14:21:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:21:41 INFO - Running post-action listener: _resource_record_post_action 14:21:41 INFO - ##### 14:21:41 INFO - ##### Running run-tests step. 14:21:41 INFO - ##### 14:21:41 INFO - Running pre-action listener: _resource_record_pre_action 14:21:41 INFO - Running main action method: run_tests 14:21:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:21:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:21:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:21:41 INFO - 2016-02-10 14:21:41.550 screenresolution[1648:7497] starting screenresolution argv=screenresolution get 14:21:41 INFO - 2016-02-10 14:21:41.552 screenresolution[1648:7497] Display 0: 1600x1200x32@60 14:21:41 INFO - 2016-02-10 14:21:41.558 screenresolution[1649:7499] starting screenresolution argv=screenresolution list 14:21:41 INFO - Available Modes on Display 0 14:21:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:21:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:21:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:21:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:21:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:21:41 INFO - Intel Iris: 14:21:41 INFO - Chipset Model: Intel Iris 14:21:41 INFO - Type: GPU 14:21:41 INFO - Bus: Built-In 14:21:41 INFO - VRAM (Dynamic, Max): 1536 MB 14:21:41 INFO - Vendor: Intel (0x8086) 14:21:41 INFO - Device ID: 0x0a2e 14:21:41 INFO - Revision ID: 0x0009 14:21:41 INFO - Displays: 14:21:41 INFO - Display: 14:21:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:21:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:21:41 INFO - Display Serial Number: 1600x1200 60 14:21:41 INFO - Main Display: Yes 14:21:41 INFO - Mirror: Off 14:21:41 INFO - Online: Yes 14:21:41 INFO - Rotation: Supported 14:21:41 INFO - Return code: 0 14:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:21:41 INFO - Python 2.7.3 14:21:41 INFO - Return code: 0 14:21:41 INFO - grabbing minidump binary from tooltool 14:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:41 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 0x10f019d30>, '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 0x10ee3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f010b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:21:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:21:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:21:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:21:41 INFO - Return code: 0 14:21:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:21:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:21:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:21:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:21:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:21:43 INFO - Return code: 0 14:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w96PJMmuDE/Render', 14:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:43 INFO - 'HOME': '/Users/cltbld', 14:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:43 INFO - 'LOGNAME': 'cltbld', 14:21:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:21:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:43 INFO - 'MOZ_NO_REMOTE': '1', 14:21:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:21:43 INFO - 'NO_EM_RESTART': '1', 14:21:43 INFO - 'PAGER': '/bin/cat', 14:21:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:43 INFO - 'PWD': '/builds/slave/test', 14:21:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:43 INFO - 'SHELL': '/bin/bash', 14:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Yv4GDr9qB/Listeners', 14:21:43 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 14:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:43 INFO - 'USER': 'cltbld', 14:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:43 INFO - 'XPC_FLAGS': '0x0', 14:21:43 INFO - 'XPC_SERVICE_NAME': '0', 14:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:21:43 INFO - mozversion application_buildid: 20160210122822 14:21:43 INFO - mozversion application_changeset: 745c98ace7f0a3420f9b2079ece59064e5a33196 14:21:43 INFO - mozversion application_display_name: Nightly 14:21:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:21:43 INFO - mozversion application_name: Firefox 14:21:43 INFO - mozversion application_remotingname: firefox 14:21:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:21:43 INFO - mozversion application_vendor: Mozilla 14:21:43 INFO - mozversion application_version: 47.0a1 14:21:43 INFO - mozversion platform_buildid: 20160210122822 14:21:43 INFO - mozversion platform_changeset: 745c98ace7f0a3420f9b2079ece59064e5a33196 14:21:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:21:43 INFO - mozversion platform_version: 47.0a1 14:21:43 INFO - using testdate: 1455142903 14:21:43 INFO - actual date: 1455142903 14:21:43 INFO - starting webserver on 'localhost:49274' 14:21:43 INFO - SUITE-START | Running 2 tests 14:21:43 INFO - TEST-START | dromaeo_css 14:21:43 INFO - operating with platform_type : mac_ 14:21:43 INFO - Initialising browser for dromaeo_css test... 14:21:43 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp8XHYPW/profile http://localhost:49274/getInfo.html) 14:21:46 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 14:21:46 INFO - PROCESS | 1667 | colorDepth:24 14:21:46 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 14:21:46 INFO - PROCESS | 1667 | __metrics 14:21:46 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:21:46 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:47 INFO - TEST-INFO | 1667: exit 0 14:21:47 INFO - Browser initialized. 14:21:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:21:47 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp8XHYPW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:58 INFO - PROCESS | 1670 | RSS: Main: 246358016 14:21:58 INFO - PROCESS | 1670 | 14:22:49 INFO - PROCESS | 1670 | 1455142969896 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:25:00 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 14:25:02 INFO - PROCESS | 1670 | RSS: Main: 337158144 14:25:02 INFO - PROCESS | 1670 | 14:28:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 14:28:05 INFO - PROCESS | 1670 | RSS: Main: 378740736 14:28:05 INFO - PROCESS | 1670 | 14:31:07 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 14:31:08 INFO - PROCESS | 1670 | RSS: Main: 377950208 14:31:08 INFO - PROCESS | 1670 | 14:34:10 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 14:34:10 INFO - PROCESS | 1670 | RSS: Main: 345604096 14:34:10 INFO - PROCESS | 1670 | 14:37:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 14:37:14 INFO - PROCESS | 1670 | RSS: Main: 346816512 14:37:14 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 14:40:17 INFO - PROCESS | 1670 | RSS: Main: 380739584 14:40:17 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | __start_tp_report 14:40:17 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 14:40:17 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 14:40:17 INFO - PROCESS | 1670 | |i|pagename|runs| 14:40:17 INFO - PROCESS | 1670 | |0;dojo.html;2979.270078830686;3455.2225749206445;3463.116905189177;3473.583170019598;3534.1164708822794;5543.168524721284;5589.832305030845;5604.775808967642;5625.887482250358;5644.54843612511;5551.361593416748;5597.8600534986645;5609.49514543691;5618.634788738729;5627.6060675752715;5036.395632524093;5070.543651071403;5078.7460626968505;5087.236914462823;5153.536181743642;5201.9479805201845;5215.817446389377;5216.530512253897;5225.242339860718;5238.92141617876;4799.760011999403;5181.0674078665825;5194.091034069042;5197.948020519803;5203.687778733288;4535.614472769818;5192.844214673566;5197.4022987356375;5201.297824793643;5207.401148867891;4297.548757380492;4949.133901567211;5161.483851614846;5161.922571161435;5196.896062078775;5541.362743284533;5586.106223004341;5604.3835178130375;5627.549796016309;5646.2942132233475;6122.204113465221;6127.785527506516;6139.877202455926;6152.78465253714;6157.7229024694;6087.512998960073;6148.047052706837;6150.231221097363;6243.469305109071;6256.1866957295715;5753.395893431213;5760.9711951440395;5778.5377169826315;5778.56660750437;5831.912521312183;6162.075688646739;6213.689315534205;6231.657258850807;6235.594686345373;6245.875082498324;6003.249593800775;6007.639541627516;6105.542084343603;6112.938870611237;6132.386102851662;6198.2871969723155;6204.503639708812;6215.813525594149;6234.0337247726675;6236.532260080512;6036.9698151508965;6083.543734219951;6189;6191.380861913773;6201.906971395432;6100.460065610241;6129.542179248731;6135.937063216329;6136.335271946702;6139.553468857682;4798.4001999750035;4846.80612775485;4859.611231101503;4878.195097808822;4904.019196160711;4341.45731783527;4391.07787364657;4398.428204333416;4434.423524941737;4435.35687325336;5514.5864060194845;5648.435156484319;5657.688827114548;5673.716314184274;5681.77272909079;6116.515487937221;6144.754209831557;6219.751209951642;6231.376862313823;6243.75024999004;5606.411326810708;5613.887722245532;5627.155926610959;5630.986422443917;5636.2391077204875;5207.3230480037355;5321.042212401805;5332.3867755207875;5335.493128152819;5336.119540275811;6227.657478838707;6291.276503202099;6293.653849038347;6310.242770867525;6326.240851097714;6197.535184861244;6222.81331560054;6254.249490061222;6261.186045814015;6274.372562743689;6154.692265386802;6245.9063114052415;6247.250329960434;6272.968635156795;6284.717187726472;6156.876862462816;6172.629642221481;6194.5973511721595;6195.349488303663;6203.100550420074;6231.40801623845;6241.625502469867;6242.406971337716;6247.156633854372;6263.937360626335;5817.185594016925;5868.119782032729;6026.457618814327;6069.51443884497;6103.298120716175;6018.067199584071;6090.817275481742;6096.872078665461;6097.390260973867;6099.573029887865;4961.3798275215595;5914.615549989409;5944.019236825875;5949.553783466171;5955.285365756137;5883.117532370179;5963.165156878127;6024.367441418588;6088.36072212429;6130.172426722335;5949.821505354673;5975.940240597538;5988.401159884151;5988.760449581968;5995.160677505066 14:40:17 INFO - PROCESS | 1670 | |1;ext.html;488.66038103518025;523.8559396166054;525.508649412799;593.2258402784365;611.6635152192458;23449.76550234497;37143.62856371435;37302.440463393;37427.81286093572;37618.49526018959;39674.206515869664;40196;40223.79888100563;40248.59751402485;40322;9355.859662105056;9575.616975321014;9579.137877591016;9580.760480987996;9597.66408175714;9392.060793920622;9565.808683826319;9569;9569.617215311415;9674;9596.760080997961;9673.516324183798;9685;9685.661001864935;9688.515574221296;9580.712578622653;9639.132478076937;9659.130678238922;9665.855012174823;9678.999999999965;9531.428114313163;9670.9516452418;9671.516424178762;9678.225741940629;9680.612775488971;30849.537256941163;35282.592614806206;38893;39024.219515609526;39052.609473905184;3157.3876813213515;3188.5695431116733;3189.346184032268;3207.1661368044242;3212.229065024377;26980.59529107065;27275.045373411835;27324.341734037072;27547.86226068857;27638.309042273904;2739.739724726148;2785.6100145979376;2835.787315951312;2955.5418910068975;2978.8680301485515;488355;491838;492002;493040;493291;51339.22991155136;59653.40346596565;59975;60086.79826403535;60172;49922.75038624856;50349.244761328606;63382.683086585195;64160.35839641637;64420.711585768026;16277.348906043862;16293.51119466418;16415.753763693556;16480.34078636841;16486.505404837873;12672.556460524022;12788.296643684687;12788.872111278954;12813.807792883114;12831.935840320739;16585.17074146288;16910.66178676444;18705.971171585694;18718.81281187198;18868.15093320804;6493.610383377012;7427.740029098955;7594.544327340377;7602.80992975169;7675.884861727079;905.5879574793453;916.8074704312036;1014.4674046125696;1063.2344711807486;1082.5615625671617;27858.721412785613;28054.579181312296;28226;28410.85794571014;28422.431551368856;1042.223543460127;1091.4379094766202;1127.8590176227972;1173.7065733566608;1173.8473998380157;15013.549593512213;15073.321700523284;15204.543863684106;15207;15323.46367877119;547341;557628.4237157658;559061;564227;565713.1714341402;47725.76137119292;54685.179722304194;54700;54923.90152196934;54991.45008549863;1213.5873802907054;1392.3803907261172;1403.3123769353147;1404.5786264120927;1501.909885406879;26740.759451039485;26854.32864178333;27746.72253277522;28031.663211355484;28174.2956426091;43852.68441946747;44517.77741111274;44534.55465445304;44584.554154459336;44653;376523;379101;380222;380420;381768;26851.597226042017;30910;31565.684343156274;31589.36821263608;31712;39113.8044309788;39552.01119972024;39743.20513589654;39886;40016.1996760069;33527.83236083804;33730.325393491505;34045.97862064142;34234.65765342315;34346.65653343435;33393;33770.83114584412;34075.48886766651;34092.31815363729;34144.48783268303;33105.66894331026;33713;34007.659923400446;34093.48859767155;34141.48787768235;29905.953291634687;29967;30013.849930750206;30050.54924176183;30134;23239.419014524097;23540;23758;23977.76022239825;24511 14:40:17 INFO - PROCESS | 1670 | |2;jquery.html;360.03331056114337;361.77208358734003;364.0534610013964;368.4951616285689;371.4150213413874;14952.401903923857;15222.771658425105;18909.054547272633;19426;20143.697844532326;11178.16163787715;11350.318980861153;11725.179237453382;11731.944125028745;11789.941050294758;5106.923396149052;5306.628536002481;5309.017831701129;5309.575233981292;5310.840674779763;3879.7478163919395;4089.997950502116;5734.913976290359;5992.910106348409;5996.760129594811;5959.88080238395;5982.940170598282;6042.607230530023;6429.774957876475;6451.580647257937;6253.687315634223;6336.936630633681;6415.743370265231;6433.324500927405;6437.774677886275;5576.525995290405;5728.198052272685;5745;5756.395578464285;5761.510271626917;23103.306900793003;23675.289741307788;23855.522889542113;24100.915458804397;24305.513889722282;2112.186808078901;2129.33990462957;2178.4227179797367;2192.6053310404122;2201.669749537566;9665.46839923804;9762.755931101708;10158.542865571068;12413.627591172279;13382.591133595948;1768.938087166943;1780.7328900664875;1786.9429514474136;1793.5247159502742;1818.1545581304756;96937.5153124237;98304.50847745787;98602.50698746533;99748;100304.99999999927;9354.953225233967;10379.325343852626;10925.508352124174;11138.49876755548;11205.439728013567;11690.649280521598;13446.731065378637;13548.254845983565;13585.320733963263;13591.116577422436;6971.3028697129885;8462.703805366782;8471.788205294917;8496.617652205665;8529.360297977677;8490.575471226413;8511.233988941025;8536.658533658709;8604.31165506758;8614.612342444605;4000.3999400089638;4187.539370669224;4348.543402942709;4424.46906371231;4492.191405546968;1774.4144432337298;1794.4078454110113;1811.644861679811;1815.056170791181;1815.972760408595;965.8696076029646;982.4301904895144;992.4095163377779;992.9354591951644;1008.9798204035878;14908.552743417715;18275.63448731018;18379.54051148732;18421.90789046046;18510.444686659423;786.4927122006274;799.6241766369797;865.1175800683268;865.2774932931073;1014.3761586624321;7064.046353742179;8508.920159710467;10369.688909332732;10659.626913058006;10855;589489;595755;595823;757166;758966;116178;119594;120290;120541.39729301473;122053.77946220602;1129.1587767113554;1169.5497233565138;1172.5016867831307;1177.270092542612;1187.762447510484;16065.11641859709;17356.47930562085;17657.938674105284;17762.91118544399;17978;35172.94481165569;45457;46595.76702116468;47208.055838883716;48285;56933.715331423075;57451;59191.81616367563;60113.699431502566;60245;6571.80284591463;7386.519876208029;7774.18371071052;7844;7844.254795794391;9532.52337383142;11936.283822970303;11982.281063135892;12053.879461205275;12298.75402491963;10149.289549731448;10375.019990404799;10520.684379468628;10645.041946224877;10742.83885741699;3620.31214069326;9283.442993420416;9988.650397236062;10302.896971030194;10641.361518308926;7325.597092159983;10097.495125243855;10211.540480678535;10863.239573229797;10878.51046702916;6971.930280697331;7150.678219480032;7358.632068396666;7363.595002274927;7700.961495192488;9797.461139637388;10053.19574434029;10400.843987340044;10559.78880422372;10560.788784224118 14:40:17 INFO - PROCESS | 1670 | |3;mootools.html;1403.838558565764;1502.8497150284973;1555.416718730476;1770.9026003569807;1921.0970843703462;7957.522548647078;8608;8775.429597076201;8788.604512796932;8797.736067917973;7549.698012079524;8724.65101395945;8735.606897689604;8752;8754.080821513744;2174.3042226487532;2230.542738738563;2231.843770936035;2478.0583378316214;2504.136073054793;2239.8432109752325;2513.5978243481045;2518.2193520008764;2519.2945975126995;2524.394145405108;2432.3311089450367;2502.4744803591266;2505.5615267328144;2508;2508.7114981777145;2447.119037146626;2467.222824810188;2492.314613481289;2496.613024981131;2499.3251822007956;2404.8196385271;2413.879306034709;2439.1828737373003;2458.754124587527;2461.4707837814776;8759.255463285628;8857.822843543094;8860.06969268224;8861.512616806072;8878.200961913459;5379.946200537984;5474.288342515487;5474.534664553517;5485.177223416479;5506.449355064502;3622.166901612644;3636.454506834611;3732.2162345907122;3745.6254374562327;3761.849526018956;1054.8575942247776;1067.4555976451988;1079.0881704959297;1102.2945314998408;1117.0281854786306;11964.700882478008;11989.160758746892;12003.939980300043;12034.33811140387;12040.638780836502;4887.266909963463;4923.803047878117;4964.280179373971;4966.279889416014;5005.998800239894;10125.291229613857;10131.189504839742;10152.187824973984;10157.9492102539;10165.4917254137;5470.507654311131;5478.287822583118;5520.641158324696;5525.11598144295;5537.58468114893;4953.034158339161;5009.89980200394;5012.298278241049;5012.899742005139;5016.598672106223;3952.071263253133;3954.62431069048;3961.960380396217;3985.5217373914734;4020.075382662004;1124.797536443448;1131.7679875625477;1314.7764879970428;1325.787873940165;1341.5438750824767;1290.303236252432;1306.294600915514;1312.225786785801;1320.7688654485426;1345.5290648273026;8060.637271322805;8100.473469224482;8354.039285482126;8371.204735550235;8411.621477033548;1191.6901605582439;1198.874118217592;1200.7538454616783;1214.9939250303692;1223.590097317391;6137.60105593135;6162.168107305546;6232.940400131988;6244.063390491463;6264;10366.06705396503;10777.784444311226;10810.243282970274;10877.564897404016;10930.234883558074;10473.214508911862;10496.055355018085;10642.361458312525;10751.946240268748;10783.245172837984;6903.413209877116;8106;8243.175682431709;8277;8333.374996875258;6583.572067815577;7620.618969051415;7763.961180194063;7804.687812487664;7857.096433910174;9344.626214951326;9432;9660.565274562521;9689;9764.951175244078;9694.75763105928;9945.104940555095;10043.397396156253;10055.145312648507;10110;6593.868122637425;6744.7976560703255;6953.826154346182;6962.721491140298;6983.615901125487;7574.204708505748;8111.351091912751;8126;8136.552489612891;8139.186081391814;7409.888851667121;7580.431467639839;7584.924150758642;7684.577348245676;7750.961245193738;6275.995840665471;7408.222136675787;7498.812529686801;7541.924580754122;7558.697652093854;7489.962550187214;7648.885266721115;7662.310392064741;7670.7315243966195;7693.692252310068;6983.371496565131;7007.334303241184;7037.859242815012;7041.823954401181;7042.014118023379;6989.650517474208;7144.3927266182955;7146.535475194096;7153.141623005273;7155.606441645759 14:40:17 INFO - PROCESS | 1670 | |4;prototype.html;321.4358800305464;328.3334830294502;334.3463528801194;335.3527691555298;338.573397519126;5512.476314750097;5863.149843272723;6163.907541386883;6418.679066046697;6623.172103487064;6513.023046543021;6529;6529.314421985694;6540.967295163529;6560.868782624357;3905.2970465316303;4766.952330476685;4769.761511924407;4792;4793.4355120010805;4594.724316541018;4789.305550695147;4794.448638406576;4800.183968725308;4825.517448255164;4756.619470442373;4761.476237613877;4761.523847615245;4782.995570930108;4794.1610218211845;4527.615152712024;4639.907201855977;4647.60495357895;4792.353032340642;4797.256425254074;3468.1849765305133;3784.751032159381;3941.2117576484816;4053.43251944728;4059.3707975263587;5573.972130139364;6198.4731297839735;6421.229452465687;6422.967885160591;6451.161349024596;5266.499682530153;5424.538914192299;5425.782968681248;5428.37573679028;5445.918311225335;6592.703328350236;6753.189617245913;6874.175098988104;6882.655867206619;6898.965505172492;3816.656500914903;4532.977335113336;4553.590176884097;4559.065391594715;4564.315352697089;7294.197638259787;7388.335049845486;7396.556206627566;7396.630168491554;7403.888941665879;4427.114577084596;4576.153411618861;4591.334256532784;4607.631389488833;4615.26155815068;4651.325557794101;4669.995950870579;4673.929891051637;4685.906281874343;4696;5537.640053396516;5544.63959842609;5548.223248745179;5554.055810512223;5555.333359996826;6720;7013.333733295329;7020.613866237406;7025.086738723933;7035.894461583081;1602.1268408717276;1625.268629116902;1630.5515983104503;1632.0941877258235;1632.5020868635181;1000.4997501249376;1036.9377837329785;1037.2479952034864;1055.519738518972;1063.9521221545049;5464.699441530754;5691.345495268014;6524.836879077966;6572.704228309737;6593.571417857824;7254.528455650366;7259.745908893164;7277;7281.817954551178;7283.417326613858;6336.239651241881;6532.640704761284;6545.247296560957;6545.280019197884;6552.9344706553275;3708.647678470541;3863.092173339263;3889.6499315061214;3893.3186692328727;3895.902602434962;6422.325655806167;7414.666340014713;7478.06524184477;7481.513701609378;7630.961845190738;7475.775726728207;7512.661930213154;7521.962390188014;7536.7362142324755;7543.434242431839;6847.897281540781;7286.380657644054;7625.733099341496;7675.846483070307;7704.499207551491;7297.817554561178;7300.306470885257;7301.707931682673;7302.2697730226555;7305.415566754753;7233.240509746401;7233.240509746612;7237.3486386223385;7247.710091596277;7257.201707812031;7368.557886526825;7674.53952762836;7685.38516918634;7686.269804368576;7696.538207707556;4160.398246674991;4581.977090114528;4626.583607475343;4638.582527572535;4641.721496710208;6601.174853143357;7254.927450725425;7260.4554658399775;7278.272172782679;7296.452766042462;5238.528532432099;5250.632455728062;7073.752418665322;7085.787426377217;7087.61018144007;5767.221425107557;6001.489873360813;6933.4106600939485;7088;7095.858082838417;5804.796832110856;6635.137432133792;6808.9659551701925;6880.65596720172;6905.274946130584;7075.82310442243;7077.363037326665;7083.291670832876;7099.538529995534;7103.928960710534;6963.40811031068;6971.198312194163;6976.127984002;6991.440684745106;6999.12510936133 14:40:17 INFO - PROCESS | 1670 | |5;yui.html;680.3196803196803;717.9748708795194;736.5249414127887;741.729268816882;745.9925400745991;14648;14765.409383624643;14821.110733355992;14823.258837058158;14848.777268340984;12684.365781710902;12734.55429059983;15222.847771522309;15459.99510031847;15561.221938903038;705.3757424679145;862.219691179482;879.5646155153208;881.0176653031888;884.5621417398397;719.5538765965109;723.634564544904;873.1748497669705;893.7184786792172;896.865470179475;920.9815803683922;933.7712260496188;935.714607044851;936.063936063936;937.9906200937971;740.7481456304882;750.1935419424086;934.364632050209;939.2251392601097;941.8116376724648;558.9217509548625;558.9692566908818;682.4131247127466;689.0766373060123;691.8962155676638;14982.700345993127;15003.549893503212;15008.849911500854;15011.324490397958;15028.09831410108;12400.75198496025;12492;12614.74770504594;12779.29713865737;13060;9934.254930880214;9982.351147175483;9984.45085520296;9987.950060249725;10011.299209055369;3532.6643968822923;3559.60844307126;3564.3049605326974;3567.1973805893467;3572.071261472036;80372.59813700953;81179;81911;82139.17860821435;82253.58873205655;9533.236351274898;9647.951760241294;9723.367981081206;9835.901640983499;10199.18406527476;21537.676934845676;21561.784382155976;21640.134394624354;22099.558008839733;22144;7665.156832748393;7696.4227682924;7751.224877512203;7764.145943946161;8024.679012839538;4108.753474791522;4146.5853414658895;4173.269677806433;4181.080162364275;4189.685773566995;3472.461768425898;3510.9122271943406;3516.191276006533;3516.2791627716256;3517.7009954153673;640.69887153038;648.6821457485798;652.3346186889346;675.993240067593;677.7221339250883;537.6370949609077;560.2129008742723;596.7016491754123;612.3967891626833;621.7140115546808;7982.481138725964;8516.659333626585;8671.699245113157;8719.866417365702;9434.954268595146;518.085578953148;538.3943064052941;596.9194158788595;627.7489004398277;632.3076231526471;3936.2127574485216;3959.584243654375;3986.7807270600397;4021.2158629067635;4123.958760412417;91504.62743058859;92587.53706231425;95036.52481737547;95528;95531.08937821204;79722;80254.59872700598;80393.19606803975;80401;80990;68942.9658555122;68949;70338;70641.0551261417;71553.92669109968;8169.754907352789;8223.917760822314;8338.666453341799;8435.83128337442;8500.70247541333;50628.74685626548;51885.48114518807;54481.72759136179;54514.72742636262;54902;72573;72613;73457.898131527;75555.62222189074;75633.24366756262;11371.31772093677;11490.88509114898;11708.88291117078;11712;12330.753384932072;11985.22096063753;12156.878431215575;12214.08394370408;12233.449494772934;12459.813102803284;11372.601958931398;11781.882181178078;11963.401829908296;11986.880131198577;12059.638210853689;11649.650510484698;11710.297382157098;11940;11949.283043017447;11970.341631210018;9259.453650246236;10096.223538526963;11223.4388280584;11389.316641001566;12106.152569320415;9207.217386522221;9516.19112375456;9689.12797848197;9750.951245243728;9943.204543636637;8395.286400655768;9832.852507212541;10055;10076.445795481319;10151.035651613085 14:40:17 INFO - PROCESS | 1670 | __end_tp_report 14:40:17 INFO - PROCESS | 1670 | __start_cc_report 14:40:17 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1276 14:40:17 INFO - PROCESS | 1670 | __end_cc_report 14:40:17 INFO - PROCESS | 1670 | __startTimestamp1455144017637__endTimestamp 14:40:17 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | ------- Summary: start ------- 14:40:17 INFO - PROCESS | 1670 | Number of tests: 6 14:40:17 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5682.31 Median:5949.82 stddev:651.51 (11.0%) stddev-sans-first:618.04 14:40:17 INFO - PROCESS | 1670 | Values: 2979.3 3455.2 3463.1 3473.6 3534.1 5543.2 5589.8 5604.8 5625.9 5644.5 5551.4 5597.9 5609.5 5618.6 5627.6 5036.4 5070.5 5078.7 5087.2 5153.5 5201.9 5215.8 5216.5 5225.2 5238.9 4799.8 5181.1 5194.1 5197.9 5203.7 4535.6 5192.8 5197.4 5201.3 5207.4 4297.5 4949.1 5161.5 5161.9 5196.9 5541.4 5586.1 5604.4 5627.5 5646.3 6122.2 6127.8 6139.9 6152.8 6157.7 6087.5 6148.0 6150.2 6243.5 6256.2 5753.4 5761.0 5778.5 5778.6 5831.9 6162.1 6213.7 6231.7 6235.6 6245.9 6003.2 6007.6 6105.5 6112.9 6132.4 6198.3 6204.5 6215.8 6234.0 6236.5 6037.0 6083.5 6189.0 6191.4 6201.9 6100.5 6129.5 6135.9 6136.3 6139.6 4798.4 4846.8 4859.6 4878.2 4904.0 4341.5 4391.1 4398.4 4434.4 4435.4 5514.6 5648.4 5657.7 5673.7 5681.8 6116.5 6144.8 6219.8 6231.4 6243.8 5606.4 5613.9 5627.2 5631.0 5636.2 5207.3 5321.0 5332.4 5335.5 5336.1 6227.7 6291.3 6293.7 6310.2 6326.2 6197.5 6222.8 6254.2 6261.2 6274.4 6154.7 6245.9 6247.3 6273.0 6284.7 6156.9 6172.6 6194.6 6195.3 6203.1 6231.4 6241.6 6242.4 6247.2 6263.9 5817.2 5868.1 6026.5 6069.5 6103.3 6018.1 6090.8 6096.9 6097.4 6099.6 4961.4 5914.6 5944.0 5949.6 5955.3 5883.1 5963.2 6024.4 6088.4 6130.2 5949.8 5975.9 5988.4 5988.8 5995.2 14:40:17 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:60903.43 Median:36213.11 stddev:128569.76 (355.0%) stddev-sans-first:128850.41 14:40:17 INFO - PROCESS | 1670 | Values: 488.7 523.9 525.5 593.2 611.7 23449.8 37143.6 37302.4 37427.8 37618.5 39674.2 40196.0 40223.8 40248.6 40322.0 9355.9 9575.6 9579.1 9580.8 9597.7 9392.1 9565.8 9569.0 9569.6 9674.0 9596.8 9673.5 9685.0 9685.7 9688.5 9580.7 9639.1 9659.1 9665.9 9679.0 9531.4 9671.0 9671.5 9678.2 9680.6 30849.5 35282.6 38893.0 39024.2 39052.6 3157.4 3188.6 3189.3 3207.2 3212.2 26980.6 27275.0 27324.3 27547.9 27638.3 2739.7 2785.6 2835.8 2955.5 2978.9 488355.0 491838.0 492002.0 493040.0 493291.0 51339.2 59653.4 59975.0 60086.8 60172.0 49922.8 50349.2 63382.7 64160.4 64420.7 16277.3 16293.5 16415.8 16480.3 16486.5 12672.6 12788.3 12788.9 12813.8 12831.9 16585.2 16910.7 18706.0 18718.8 18868.2 6493.6 7427.7 7594.5 7602.8 7675.9 905.6 916.8 1014.5 1063.2 1082.6 27858.7 28054.6 28226.0 28410.9 28422.4 1042.2 1091.4 1127.9 1173.7 1173.8 15013.5 15073.3 15204.5 15207.0 15323.5 547341.0 557628.4 559061.0 564227.0 565713.2 47725.8 54685.2 54700.0 54923.9 54991.5 1213.6 1392.4 1403.3 1404.6 1501.9 26740.8 26854.3 27746.7 28031.7 28174.3 43852.7 44517.8 44534.6 44584.6 44653.0 376523.0 379101.0 380222.0 380420.0 381768.0 26851.6 30910.0 31565.7 31589.4 31712.0 39113.8 39552.0 39743.2 39886.0 40016.2 33527.8 33730.3 34046.0 34234.7 34346.7 33393.0 33770.8 34075.5 34092.3 34144.5 33105.7 33713.0 34007.7 34093.5 34141.5 29906.0 29967.0 30013.8 30050.5 30134.0 23239.4 23540.0 23758.0 23977.8 24511.0 14:40:17 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:34399.39 Median:1992.18 stddev:109778.69 (5510.5%) stddev-sans-first:110056.89 14:40:17 INFO - PROCESS | 1670 | Values: 360.0 361.8 364.1 368.5 371.4 14952.4 15222.8 18909.1 19426.0 20143.7 11178.2 11350.3 11725.2 11731.9 11789.9 5106.9 5306.6 5309.0 5309.6 5310.8 3879.7 4090.0 5734.9 5992.9 5996.8 5959.9 5982.9 6042.6 6429.8 6451.6 6253.7 6336.9 6415.7 6433.3 6437.8 5576.5 5728.2 5745.0 5756.4 5761.5 23103.3 23675.3 23855.5 24100.9 24305.5 2112.2 2129.3 2178.4 2192.6 2201.7 9665.5 9762.8 10158.5 12413.6 13382.6 1768.9 1780.7 1786.9 1793.5 1818.2 96937.5 98304.5 98602.5 99748.0 100305.0 9355.0 10379.3 10925.5 11138.5 11205.4 11690.6 13446.7 13548.3 13585.3 13591.1 6971.3 8462.7 8471.8 8496.6 8529.4 8490.6 8511.2 8536.7 8604.3 8614.6 4000.4 4187.5 4348.5 4424.5 4492.2 1774.4 1794.4 1811.6 1815.1 1816.0 965.9 982.4 992.4 992.9 1009.0 14908.6 18275.6 18379.5 18421.9 18510.4 786.5 799.6 865.1 865.3 1014.4 7064.0 8508.9 10369.7 10659.6 10855.0 589489.0 595755.0 595823.0 757166.0 758966.0 116178.0 119594.0 120290.0 120541.4 122053.8 1129.2 1169.5 1172.5 1177.3 1187.8 16065.1 17356.5 17657.9 17762.9 17978.0 35172.9 45457.0 46595.8 47208.1 48285.0 56933.7 57451.0 59191.8 60113.7 60245.0 6571.8 7386.5 7774.2 7844.0 7844.3 9532.5 11936.3 11982.3 12053.9 12298.8 10149.3 10375.0 10520.7 10645.0 10742.8 3620.3 9283.4 9988.7 10302.9 10641.4 7325.6 10097.5 10211.5 10863.2 10878.5 6971.9 7150.7 7358.6 7363.6 7701.0 9797.5 10053.2 10400.8 10559.8 10560.8 14:40:17 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6048.67 Median:5012.60 stddev:3169.77 (63.2%) stddev-sans-first:3159.43 14:40:17 INFO - PROCESS | 1670 | Values: 1403.8 1502.8 1555.4 1770.9 1921.1 7957.5 8608.0 8775.4 8788.6 8797.7 7549.7 8724.7 8735.6 8752.0 8754.1 2174.3 2230.5 2231.8 2478.1 2504.1 2239.8 2513.6 2518.2 2519.3 2524.4 2432.3 2502.5 2505.6 2508.0 2508.7 2447.1 2467.2 2492.3 2496.6 2499.3 2404.8 2413.9 2439.2 2458.8 2461.5 8759.3 8857.8 8860.1 8861.5 8878.2 5379.9 5474.3 5474.5 5485.2 5506.4 3622.2 3636.5 3732.2 3745.6 3761.8 1054.9 1067.5 1079.1 1102.3 1117.0 11964.7 11989.2 12003.9 12034.3 12040.6 4887.3 4923.8 4964.3 4966.3 5006.0 10125.3 10131.2 10152.2 10157.9 10165.5 5470.5 5478.3 5520.6 5525.1 5537.6 4953.0 5009.9 5012.3 5012.9 5016.6 3952.1 3954.6 3962.0 3985.5 4020.1 1124.8 1131.8 1314.8 1325.8 1341.5 1290.3 1306.3 1312.2 1320.8 1345.5 8060.6 8100.5 8354.0 8371.2 8411.6 1191.7 1198.9 1200.8 1215.0 1223.6 6137.6 6162.2 6232.9 6244.1 6264.0 10366.1 10777.8 10810.2 10877.6 10930.2 10473.2 10496.1 10642.4 10751.9 10783.2 6903.4 8106.0 8243.2 8277.0 8333.4 6583.6 7620.6 7764.0 7804.7 7857.1 9344.6 9432.0 9660.6 9689.0 9765.0 9694.8 9945.1 10043.4 10055.1 10110.0 6593.9 6744.8 6953.8 6962.7 6983.6 7574.2 8111.4 8126.0 8136.6 8139.2 7409.9 7580.4 7584.9 7684.6 7751.0 6276.0 7408.2 7498.8 7541.9 7558.7 7490.0 7648.9 7662.3 7670.7 7693.7 6983.4 7007.3 7037.9 7041.8 7042.0 6989.7 7144.4 7146.5 7153.1 7155.6 14:40:17 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5659.10 Median:6422.65 stddev:1839.31 (28.6%) stddev-sans-first:1800.31 14:40:17 INFO - PROCESS | 1670 | Values: 321.4 328.3 334.3 335.4 338.6 5512.5 5863.1 6163.9 6418.7 6623.2 6513.0 6529.0 6529.3 6541.0 6560.9 3905.3 4767.0 4769.8 4792.0 4793.4 4594.7 4789.3 4794.4 4800.2 4825.5 4756.6 4761.5 4761.5 4783.0 4794.2 4527.6 4639.9 4647.6 4792.4 4797.3 3468.2 3784.8 3941.2 4053.4 4059.4 5574.0 6198.5 6421.2 6423.0 6451.2 5266.5 5424.5 5425.8 5428.4 5445.9 6592.7 6753.2 6874.2 6882.7 6899.0 3816.7 4533.0 4553.6 4559.1 4564.3 7294.2 7388.3 7396.6 7396.6 7403.9 4427.1 4576.2 4591.3 4607.6 4615.3 4651.3 4670.0 4673.9 4685.9 4696.0 5537.6 5544.6 5548.2 5554.1 5555.3 6720.0 7013.3 7020.6 7025.1 7035.9 1602.1 1625.3 1630.6 1632.1 1632.5 1000.5 1036.9 1037.2 1055.5 1064.0 5464.7 5691.3 6524.8 6572.7 6593.6 7254.5 7259.7 7277.0 7281.8 7283.4 6336.2 6532.6 6545.2 6545.3 6552.9 3708.6 3863.1 3889.6 3893.3 3895.9 6422.3 7414.7 7478.1 7481.5 7631.0 7475.8 7512.7 7522.0 7536.7 7543.4 6847.9 7286.4 7625.7 7675.8 7704.5 7297.8 7300.3 7301.7 7302.3 7305.4 7233.2 7233.2 7237.3 7247.7 7257.2 7368.6 7674.5 7685.4 7686.3 7696.5 4160.4 4582.0 4626.6 4638.6 4641.7 6601.2 7254.9 7260.5 7278.3 7296.5 5238.5 5250.6 7073.8 7085.8 7087.6 5767.2 6001.5 6933.4 7088.0 7095.9 5804.8 6635.1 6809.0 6880.7 6905.3 7075.8 7077.4 7083.3 7099.5 7103.9 6963.4 6971.2 6976.1 6991.4 6999.1 14:40:17 INFO - PROCESS | 1670 | 14:40:17 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18779.29 Median:636.50 stddev:26484.84 (4161.0%) stddev-sans-first:26524.27 14:40:17 INFO - PROCESS | 1670 | Values: 680.3 718.0 736.5 741.7 746.0 14648.0 14765.4 14821.1 14823.3 14848.8 12684.4 12734.6 15222.8 15460.0 15561.2 705.4 862.2 879.6 881.0 884.6 719.6 723.6 873.2 893.7 896.9 921.0 933.8 935.7 936.1 938.0 740.7 750.2 934.4 939.2 941.8 558.9 559.0 682.4 689.1 691.9 14982.7 15003.5 15008.8 15011.3 15028.1 12400.8 12492.0 12614.7 12779.3 13060.0 9934.3 9982.4 9984.5 9988.0 10011.3 3532.7 3559.6 3564.3 3567.2 3572.1 80372.6 81179.0 81911.0 82139.2 82253.6 9533.2 9648.0 9723.4 9835.9 10199.2 21537.7 21561.8 21640.1 22099.6 22144.0 7665.2 7696.4 7751.2 7764.1 8024.7 4108.8 4146.6 4173.3 4181.1 4189.7 3472.5 3510.9 3516.2 3516.3 3517.7 640.7 648.7 652.3 676.0 677.7 537.6 560.2 596.7 612.4 621.7 7982.5 8516.7 8671.7 8719.9 9435.0 518.1 538.4 596.9 627.7 632.3 3936.2 3959.6 3986.8 4021.2 4124.0 91504.6 92587.5 95036.5 95528.0 95531.1 79722.0 80254.6 80393.2 80401.0 80990.0 68943.0 68949.0 70338.0 70641.1 71553.9 8169.8 8223.9 8338.7 8435.8 8500.7 50628.7 51885.5 54481.7 54514.7 54902.0 72573.0 72613.0 73457.9 75555.6 75633.2 11371.3 11490.9 11708.9 11712.0 12330.8 11985.2 12156.9 12214.1 12233.4 12459.8 11372.6 11781.9 11963.4 11986.9 12059.6 11649.7 11710.3 11940.0 11949.3 11970.3 9259.5 10096.2 11223.4 11389.3 12106.2 9207.2 9516.2 9689.1 9751.0 9943.2 8395.3 9832.9 10055.0 10076.4 10151.0 14:40:17 INFO - PROCESS | 1670 | -------- Summary: end -------- 14:40:17 INFO - PROCESS | 1670 | 14:40:18 INFO - TEST-INFO | 1670: exit 0 14:40:18 INFO - TEST-OK | dromaeo_css | took 1114388ms 14:40:18 INFO - TEST-START | kraken 14:40:18 INFO - operating with platform_type : mac_ 14:40:18 INFO - Initialising browser for kraken test... 14:40:18 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpDWvZ6L/profile http://localhost:49274/getInfo.html) 14:40:20 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 14:40:20 INFO - PROCESS | 1681 | colorDepth:24 14:40:20 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 14:40:20 INFO - PROCESS | 1681 | __metrics 14:40:20 INFO - PROCESS | 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:40:20 INFO - PROCESS | 1681 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:40:21 INFO - TEST-INFO | 1681: exit 0 14:40:21 INFO - Browser initialized. 14:40:21 INFO - Running cycle 1/1 for kraken test... 14:40:21 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpDWvZ6L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:33 INFO - PROCESS | 1683 | RSS: Main: 246616064 14:40:33 INFO - PROCESS | 1683 | 14:40:35 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 14:40:36 INFO - PROCESS | 1683 | RSS: Main: 293572608 14:40:36 INFO - PROCESS | 1683 | 14:40:38 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 14:40:39 INFO - PROCESS | 1683 | RSS: Main: 301944832 14:40:39 INFO - PROCESS | 1683 | 14:40:42 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 14:40:43 INFO - PROCESS | 1683 | RSS: Main: 285646848 14:40:43 INFO - PROCESS | 1683 | 14:40:45 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 14:40:45 INFO - PROCESS | 1683 | RSS: Main: 288276480 14:40:45 INFO - PROCESS | 1683 | 14:40:47 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:40:48 INFO - PROCESS | 1683 | RSS: Main: 289382400 14:40:48 INFO - PROCESS | 1683 | 14:40:51 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 14:40:51 INFO - PROCESS | 1683 | RSS: Main: 291422208 14:40:51 INFO - PROCESS | 1683 | 14:40:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 14:40:55 INFO - PROCESS | 1683 | RSS: Main: 289824768 14:40:55 INFO - PROCESS | 1683 | 14:40:57 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 14:40:58 INFO - PROCESS | 1683 | RSS: Main: 290197504 14:40:58 INFO - PROCESS | 1683 | 14:41:00 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:00 INFO - PROCESS | 1683 | RSS: Main: 325627904 14:41:00 INFO - PROCESS | 1683 | 14:41:02 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:03 INFO - PROCESS | 1683 | RSS: Main: 325464064 14:41:03 INFO - PROCESS | 1683 | 14:41:05 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:05 INFO - PROCESS | 1683 | RSS: Main: 334606336 14:41:05 INFO - PROCESS | 1683 | 14:41:08 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:41:08 INFO - PROCESS | 1683 | RSS: Main: 335470592 14:41:08 INFO - PROCESS | 1683 | 14:41:11 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:41:11 INFO - PROCESS | 1683 | RSS: Main: 335712256 14:41:11 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 14:41:13 INFO - PROCESS | 1683 | RSS: Main: 395046912 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | __start_tp_report 14:41:13 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 14:41:13 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 14:41:13 INFO - PROCESS | 1683 | |i|pagename|runs| 14:41:13 INFO - PROCESS | 1683 | |0;ai-astar;111;106;111;110;110;109;114;110;111;110 14:41:13 INFO - PROCESS | 1683 | |1;audio-beat-detection;156;123;144;158;121;141;139;116;158;140 14:41:13 INFO - PROCESS | 1683 | |2;audio-dft;185;184;185;187;185;186;185;185;181;182 14:41:13 INFO - PROCESS | 1683 | |3;audio-fft;79;73;82;77;57;58;57;80;76;55 14:41:13 INFO - PROCESS | 1683 | |4;audio-oscillator;93;94;125;79;81;80;133;104;109;145 14:41:13 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;83;89;83;89;83;89;84;89;83;88 14:41:13 INFO - PROCESS | 1683 | |6;imaging-darkroom;93;92;94;92;92;93;93;93;93;93 14:41:13 INFO - PROCESS | 1683 | |7;imaging-desaturate;86;87;87;84;86;87;86;87;87;85 14:41:13 INFO - PROCESS | 1683 | |8;json-parse-financial;56;55;56;53;52;53;53;63;51;54 14:41:13 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;62;70;71;74;67;67;64;64;65;66 14:41:13 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;82;82;84;82;82;82;89;102;100;81 14:41:13 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;129;124;129;125;119;122;124;118;120;122 14:41:13 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;160;129;136;134;137;125;136;137;136;135 14:41:13 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;66;66;65;65;67;66;67;65;65;66 14:41:13 INFO - PROCESS | 1683 | __end_tp_report 14:41:13 INFO - PROCESS | 1683 | __start_cc_report 14:41:13 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1132 14:41:13 INFO - PROCESS | 1683 | __end_cc_report 14:41:13 INFO - PROCESS | 1683 | __startTimestamp1455144073859__endTimestamp 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | ------- Summary: start ------- 14:41:13 INFO - PROCESS | 1683 | Number of tests: 14 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.99 (1.8%) stddev-sans-first:2.09 14:41:13 INFO - PROCESS | 1683 | Values: 111.0 106.0 111.0 110.0 110.0 109.0 114.0 110.0 111.0 110.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:142.50 stddev:15.44 (10.8%) stddev-sans-first:15.20 14:41:13 INFO - PROCESS | 1683 | Values: 156.0 123.0 144.0 158.0 121.0 141.0 139.0 116.0 158.0 140.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.78 (1.0%) stddev-sans-first:1.88 14:41:13 INFO - PROCESS | 1683 | Values: 185.0 184.0 185.0 187.0 185.0 186.0 185.0 185.0 181.0 182.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:69.40 Median:76.50 stddev:11.17 (14.6%) stddev-sans-first:11.29 14:41:13 INFO - PROCESS | 1683 | Values: 79.0 73.0 82.0 77.0 57.0 58.0 57.0 80.0 76.0 55.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:79.50 stddev:23.42 (29.5%) stddev-sans-first:24.49 14:41:13 INFO - PROCESS | 1683 | Values: 93.0 94.0 125.0 79.0 81.0 80.0 133.0 104.0 109.0 145.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:88.50 stddev:2.98 (3.4%) stddev-sans-first:2.96 14:41:13 INFO - PROCESS | 1683 | Values: 83.0 89.0 83.0 89.0 83.0 89.0 84.0 89.0 83.0 88.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:41:13 INFO - PROCESS | 1683 | Values: 93.0 92.0 94.0 92.0 92.0 93.0 93.0 93.0 93.0 93.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:87.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 14:41:13 INFO - PROCESS | 1683 | Values: 86.0 87.0 87.0 84.0 86.0 87.0 86.0 87.0 87.0 85.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:3.37 (6.2%) stddev-sans-first:3.54 14:41:13 INFO - PROCESS | 1683 | Values: 56.0 55.0 56.0 53.0 52.0 53.0 53.0 63.0 51.0 54.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:3.68 (5.5%) stddev-sans-first:3.43 14:41:13 INFO - PROCESS | 1683 | Values: 62.0 70.0 71.0 74.0 67.0 67.0 64.0 64.0 65.0 66.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:82.00 stddev:7.93 (9.7%) stddev-sans-first:8.24 14:41:13 INFO - PROCESS | 1683 | Values: 82.0 82.0 84.0 82.0 82.0 82.0 89.0 102.0 100.0 81.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:3.79 (3.1%) stddev-sans-first:3.40 14:41:13 INFO - PROCESS | 1683 | Values: 129.0 124.0 129.0 125.0 119.0 122.0 124.0 118.0 120.0 122.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.50 Median:136.00 stddev:9.13 (6.7%) stddev-sans-first:4.14 14:41:13 INFO - PROCESS | 1683 | Values: 160.0 129.0 136.0 134.0 137.0 125.0 136.0 137.0 136.0 135.0 14:41:13 INFO - PROCESS | 1683 | 14:41:13 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 14:41:13 INFO - PROCESS | 1683 | Values: 66.0 66.0 65.0 65.0 67.0 66.0 67.0 65.0 65.0 66.0 14:41:13 INFO - PROCESS | 1683 | -------- Summary: end -------- 14:41:13 INFO - PROCESS | 1683 | 14:41:14 INFO - TEST-INFO | 1683: exit 0 14:41:14 INFO - TEST-OK | kraken | took 56450ms 14:41:14 INFO - SUITE-END | took 1170s 14:41:15 INFO - Completed test suite (00:19:31) 14:41:15 INFO - Working with test: dromaeo_css 14:41:15 INFO - Generating results file: dromaeo_css 14:41:15 INFO - Working with test: kraken 14:41:15 INFO - Generating results file: kraken 14:41:15 INFO - javascript benchmark 14:41:15 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:41:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 14:41:15 INFO - process_Request line: dromaeo_css 7394.67 graph.html#tests=[[72,64,59]] 14:41:15 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:41:15 INFO - process_Request line: kraken 1406.70 graph.html#tests=[[232,64,59]] 14:41:15 INFO - RETURN: dromaeo_css: 7394.67 14:41:15 INFO - RETURN: kraken: 1406.70 14:41:15 INFO - javascript benchmark 14:41:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2979.270078830686, 3455.2225749206445, 3463.116905189177, 3473.583170019598, 3534.1164708822794, 5543.168524721284, 5589.832305030845, 5604.775808967642, 5625.887482250358, 5644.54843612511, 5551.361593416748, 5597.8600534986645, 5609.49514543691, 5618.634788738729, 5627.6060675752715, 5036.395632524093, 5070.543651071403, 5078.7460626968505, 5087.236914462823, 5153.536181743642, 5201.9479805201845, 5215.817446389377, 5216.530512253897, 5225.242339860718, 5238.92141617876, 4799.760011999403, 5181.0674078665825, 5194.091034069042, 5197.948020519803, 5203.687778733288, 4535.614472769818, 5192.844214673566, 5197.4022987356375, 5201.297824793643, 5207.401148867891, 4297.548757380492, 4949.133901567211, 5161.483851614846, 5161.922571161435, 5196.896062078775, 5541.362743284533, 5586.106223004341, 5604.3835178130375, 5627.549796016309, 5646.2942132233475, 6122.204113465221, 6127.785527506516, 6139.877202455926, 6152.78465253714, 6157.7229024694, 6087.512998960073, 6148.047052706837, 6150.231221097363, 6243.469305109071, 6256.1866957295715, 5753.395893431213, 5760.9711951440395, 5778.5377169826315, 5778.56660750437, 5831.912521312183, 6162.075688646739, 6213.689315534205, 6231.657258850807, 6235.594686345373, 6245.875082498324, 6003.249593800775, 6007.639541627516, 6105.542084343603, 6112.938870611237, 6132.386102851662, 6198.2871969723155, 6204.503639708812, 6215.813525594149, 6234.0337247726675, 6236.532260080512, 6036.9698151508965, 6083.543734219951, 6189.0, 6191.380861913773, 6201.906971395432, 6100.460065610241, 6129.542179248731, 6135.937063216329, 6136.335271946702, 6139.553468857682, 4798.4001999750035, 4846.80612775485, 4859.611231101503, 4878.195097808822, 4904.019196160711, 4341.45731783527, 4391.07787364657, 4398.428204333416, 4434.423524941737, 4435.35687325336, 5514.5864060194845, 5648.435156484319, 5657.688827114548, 5673.716314184274, 5681.77272909079, 6116.515487937221, 6144.754209831557, 6219.751209951642, 6231.376862313823, 6243.75024999004, 5606.411326810708, 5613.887722245532, 5627.155926610959, 5630.986422443917, 5636.2391077204875, 5207.3230480037355, 5321.042212401805, 5332.3867755207875, 5335.493128152819, 5336.119540275811, 6227.657478838707, 6291.276503202099, 6293.653849038347, 6310.242770867525, 6326.240851097714, 6197.535184861244, 6222.81331560054, 6254.249490061222, 6261.186045814015, 6274.372562743689, 6154.692265386802, 6245.9063114052415, 6247.250329960434, 6272.968635156795, 6284.717187726472, 6156.876862462816, 6172.629642221481, 6194.5973511721595, 6195.349488303663, 6203.100550420074, 6231.40801623845, 6241.625502469867, 6242.406971337716, 6247.156633854372, 6263.937360626335, 5817.185594016925, 5868.119782032729, 6026.457618814327, 6069.51443884497, 6103.298120716175, 6018.067199584071, 6090.817275481742, 6096.872078665461, 6097.390260973867, 6099.573029887865, 4961.3798275215595, 5914.615549989409, 5944.019236825875, 5949.553783466171, 5955.285365756137, 5883.117532370179, 5963.165156878127, 6024.367441418588, 6088.36072212429, 6130.172426722335, 5949.821505354673, 5975.940240597538, 5988.401159884151, 5988.760449581968, 5995.160677505066], "unit": "score", "name": "dojo.html", "value": 5640.219363909725}, {"lowerIsBetter": false, "replicates": [488.66038103518025, 523.8559396166054, 525.508649412799, 593.2258402784365, 611.6635152192458, 23449.76550234497, 37143.62856371435, 37302.440463393, 37427.81286093572, 37618.49526018959, 39674.206515869664, 40196.0, 40223.79888100563, 40248.59751402485, 40322.0, 9355.859662105056, 9575.616975321014, 9579.137877591016, 9580.760480987996, 9597.66408175714, 9392.060793920622, 9565.808683826319, 9569.0, 9569.617215311415, 9674.0, 9596.760080997961, 9673.516324183798, 9685.0, 9685.661001864935, 9688.515574221296, 9580.712578622653, 9639.132478076937, 9659.130678238922, 9665.855012174823, 9678.999999999965, 9531.428114313163, 9670.9516452418, 9671.516424178762, 9678.225741940629, 9680.612775488971, 30849.537256941163, 35282.592614806206, 38893.0, 39024.219515609526, 39052.609473905184, 3157.3876813213515, 3188.5695431116733, 3189.346184032268, 3207.1661368044242, 3212.229065024377, 26980.59529107065, 27275.045373411835, 27324.341734037072, 27547.86226068857, 27638.309042273904, 2739.739724726148, 2785.6100145979376, 2835.787315951312, 2955.5418910068975, 2978.8680301485515, 488355.0, 491838.0, 492002.0, 493040.0, 493291.0, 51339.22991155136, 59653.40346596565, 59975.0, 60086.79826403535, 60172.0, 49922.75038624856, 50349.244761328606, 63382.683086585195, 64160.35839641637, 64420.711585768026, 16277.348906043862, 16293.51119466418, 16415.753763693556, 16480.34078636841, 16486.505404837873, 12672.556460524022, 12788.296643684687, 12788.872111278954, 12813.807792883114, 12831.935840320739, 16585.17074146288, 16910.66178676444, 18705.971171585694, 18718.81281187198, 18868.15093320804, 6493.610383377012, 7427.740029098955, 7594.544327340377, 7602.80992975169, 7675.884861727079, 905.5879574793453, 916.8074704312036, 1014.4674046125696, 1063.2344711807486, 1082.5615625671617, 27858.721412785613, 28054.579181312296, 28226.0, 28410.85794571014, 28422.431551368856, 1042.223543460127, 1091.4379094766202, 1127.8590176227972, 1173.7065733566608, 1173.8473998380157, 15013.549593512213, 15073.321700523284, 15204.543863684106, 15207.0, 15323.46367877119, 547341.0, 557628.4237157658, 559061.0, 564227.0, 565713.1714341402, 47725.76137119292, 54685.179722304194, 54700.0, 54923.90152196934, 54991.45008549863, 1213.5873802907054, 1392.3803907261172, 1403.3123769353147, 1404.5786264120927, 1501.909885406879, 26740.759451039485, 26854.32864178333, 27746.72253277522, 28031.663211355484, 28174.2956426091, 43852.68441946747, 44517.77741111274, 44534.55465445304, 44584.554154459336, 44653.0, 376523.0, 379101.0, 380222.0, 380420.0, 381768.0, 26851.597226042017, 30910.0, 31565.684343156274, 31589.36821263608, 31712.0, 39113.8044309788, 39552.01119972024, 39743.20513589654, 39886.0, 40016.1996760069, 33527.83236083804, 33730.325393491505, 34045.97862064142, 34234.65765342315, 34346.65653343435, 33393.0, 33770.83114584412, 34075.48886766651, 34092.31815363729, 34144.48783268303, 33105.66894331026, 33713.0, 34007.659923400446, 34093.48859767155, 34141.48787768235, 29905.953291634687, 29967.0, 30013.849930750206, 30050.54924176183, 30134.0, 23239.419014524097, 23540.0, 23758.0, 23977.76022239825, 24511.0], "unit": "score", "name": "ext.html", "value": 18852.18264238473}, {"lowerIsBetter": false, "replicates": [360.03331056114337, 361.77208358734003, 364.0534610013964, 368.4951616285689, 371.4150213413874, 14952.401903923857, 15222.771658425105, 18909.054547272633, 19426.0, 20143.697844532326, 11178.16163787715, 11350.318980861153, 11725.179237453382, 11731.944125028745, 11789.941050294758, 5106.923396149052, 5306.628536002481, 5309.017831701129, 5309.575233981292, 5310.840674779763, 3879.7478163919395, 4089.997950502116, 5734.913976290359, 5992.910106348409, 5996.760129594811, 5959.88080238395, 5982.940170598282, 6042.607230530023, 6429.774957876475, 6451.580647257937, 6253.687315634223, 6336.936630633681, 6415.743370265231, 6433.324500927405, 6437.774677886275, 5576.525995290405, 5728.198052272685, 5745.0, 5756.395578464285, 5761.510271626917, 23103.306900793003, 23675.289741307788, 23855.522889542113, 24100.915458804397, 24305.513889722282, 2112.186808078901, 2129.33990462957, 2178.4227179797367, 2192.6053310404122, 2201.669749537566, 9665.46839923804, 9762.755931101708, 10158.542865571068, 12413.627591172279, 13382.591133595948, 1768.938087166943, 1780.7328900664875, 1786.9429514474136, 1793.5247159502742, 1818.1545581304756, 96937.5153124237, 98304.50847745787, 98602.50698746533, 99748.0, 100304.99999999927, 9354.953225233967, 10379.325343852626, 10925.508352124174, 11138.49876755548, 11205.439728013567, 11690.649280521598, 13446.731065378637, 13548.254845983565, 13585.320733963263, 13591.116577422436, 6971.3028697129885, 8462.703805366782, 8471.788205294917, 8496.617652205665, 8529.360297977677, 8490.575471226413, 8511.233988941025, 8536.658533658709, 8604.31165506758, 8614.612342444605, 4000.3999400089638, 4187.539370669224, 4348.543402942709, 4424.46906371231, 4492.191405546968, 1774.4144432337298, 1794.4078454110113, 1811.644861679811, 1815.056170791181, 1815.972760408595, 965.8696076029646, 982.4301904895144, 992.4095163377779, 992.9354591951644, 1008.9798204035878, 14908.552743417715, 18275.63448731018, 18379.54051148732, 18421.90789046046, 18510.444686659423, 786.4927122006274, 799.6241766369797, 865.1175800683268, 865.2774932931073, 1014.3761586624321, 7064.046353742179, 8508.920159710467, 10369.688909332732, 10659.626913058006, 10855.0, 589489.0, 595755.0, 595823.0, 757166.0, 758966.0, 116178.0, 119594.0, 120290.0, 120541.39729301473, 122053.77946220602, 1129.1587767113554, 1169.5497233565138, 1172.5016867831307, 1177.270092542612, 1187.762447510484, 16065.11641859709, 17356.47930562085, 17657.938674105284, 17762.91118544399, 17978.0, 35172.94481165569, 45457.0, 46595.76702116468, 47208.055838883716, 48285.0, 56933.715331423075, 57451.0, 59191.81616367563, 60113.699431502566, 60245.0, 6571.80284591463, 7386.519876208029, 7774.18371071052, 7844.0, 7844.254795794391, 9532.52337383142, 11936.283822970303, 11982.281063135892, 12053.879461205275, 12298.75402491963, 10149.289549731448, 10375.019990404799, 10520.684379468628, 10645.041946224877, 10742.83885741699, 3620.31214069326, 9283.442993420416, 9988.650397236062, 10302.896971030194, 10641.361518308926, 7325.597092159983, 10097.495125243855, 10211.540480678535, 10863.239573229797, 10878.51046702916, 6971.930280697331, 7150.678219480032, 7358.632068396666, 7363.595002274927, 7700.961495192488, 9797.461139637388, 10053.19574434029, 10400.843987340044, 10559.78880422372, 10560.788784224118], "unit": "score", "name": "jquery.html", "value": 8852.377790142215}, {"lowerIsBetter": false, "replicates": [1403.838558565764, 1502.8497150284973, 1555.416718730476, 1770.9026003569807, 1921.0970843703462, 7957.522548647078, 8608.0, 8775.429597076201, 8788.604512796932, 8797.736067917973, 7549.698012079524, 8724.65101395945, 8735.606897689604, 8752.0, 8754.080821513744, 2174.3042226487532, 2230.542738738563, 2231.843770936035, 2478.0583378316214, 2504.136073054793, 2239.8432109752325, 2513.5978243481045, 2518.2193520008764, 2519.2945975126995, 2524.394145405108, 2432.3311089450367, 2502.4744803591266, 2505.5615267328144, 2508.0, 2508.7114981777145, 2447.119037146626, 2467.222824810188, 2492.314613481289, 2496.613024981131, 2499.3251822007956, 2404.8196385271, 2413.879306034709, 2439.1828737373003, 2458.754124587527, 2461.4707837814776, 8759.255463285628, 8857.822843543094, 8860.06969268224, 8861.512616806072, 8878.200961913459, 5379.946200537984, 5474.288342515487, 5474.534664553517, 5485.177223416479, 5506.449355064502, 3622.166901612644, 3636.454506834611, 3732.2162345907122, 3745.6254374562327, 3761.849526018956, 1054.8575942247776, 1067.4555976451988, 1079.0881704959297, 1102.2945314998408, 1117.0281854786306, 11964.700882478008, 11989.160758746892, 12003.939980300043, 12034.33811140387, 12040.638780836502, 4887.266909963463, 4923.803047878117, 4964.280179373971, 4966.279889416014, 5005.998800239894, 10125.291229613857, 10131.189504839742, 10152.187824973984, 10157.9492102539, 10165.4917254137, 5470.507654311131, 5478.287822583118, 5520.641158324696, 5525.11598144295, 5537.58468114893, 4953.034158339161, 5009.89980200394, 5012.298278241049, 5012.899742005139, 5016.598672106223, 3952.071263253133, 3954.62431069048, 3961.960380396217, 3985.5217373914734, 4020.075382662004, 1124.797536443448, 1131.7679875625477, 1314.7764879970428, 1325.787873940165, 1341.5438750824767, 1290.303236252432, 1306.294600915514, 1312.225786785801, 1320.7688654485426, 1345.5290648273026, 8060.637271322805, 8100.473469224482, 8354.039285482126, 8371.204735550235, 8411.621477033548, 1191.6901605582439, 1198.874118217592, 1200.7538454616783, 1214.9939250303692, 1223.590097317391, 6137.60105593135, 6162.168107305546, 6232.940400131988, 6244.063390491463, 6264.0, 10366.06705396503, 10777.784444311226, 10810.243282970274, 10877.564897404016, 10930.234883558074, 10473.214508911862, 10496.055355018085, 10642.361458312525, 10751.946240268748, 10783.245172837984, 6903.413209877116, 8106.0, 8243.175682431709, 8277.0, 8333.374996875258, 6583.572067815577, 7620.618969051415, 7763.961180194063, 7804.687812487664, 7857.096433910174, 9344.626214951326, 9432.0, 9660.565274562521, 9689.0, 9764.951175244078, 9694.75763105928, 9945.104940555095, 10043.397396156253, 10055.145312648507, 10110.0, 6593.868122637425, 6744.7976560703255, 6953.826154346182, 6962.721491140298, 6983.615901125487, 7574.204708505748, 8111.351091912751, 8126.0, 8136.552489612891, 8139.186081391814, 7409.888851667121, 7580.431467639839, 7584.924150758642, 7684.577348245676, 7750.961245193738, 6275.995840665471, 7408.222136675787, 7498.812529686801, 7541.924580754122, 7558.697652093854, 7489.962550187214, 7648.885266721115, 7662.310392064741, 7670.7315243966195, 7693.692252310068, 6983.371496565131, 7007.334303241184, 7037.859242815012, 7041.823954401181, 7042.014118023379, 6989.650517474208, 7144.3927266182955, 7146.535475194096, 7153.141623005273, 7155.606441645759], "unit": "score", "name": "mootools.html", "value": 4949.514718755491}, {"lowerIsBetter": false, "replicates": [321.4358800305464, 328.3334830294502, 334.3463528801194, 335.3527691555298, 338.573397519126, 5512.476314750097, 5863.149843272723, 6163.907541386883, 6418.679066046697, 6623.172103487064, 6513.023046543021, 6529.0, 6529.314421985694, 6540.967295163529, 6560.868782624357, 3905.2970465316303, 4766.952330476685, 4769.761511924407, 4792.0, 4793.4355120010805, 4594.724316541018, 4789.305550695147, 4794.448638406576, 4800.183968725308, 4825.517448255164, 4756.619470442373, 4761.476237613877, 4761.523847615245, 4782.995570930108, 4794.1610218211845, 4527.615152712024, 4639.907201855977, 4647.60495357895, 4792.353032340642, 4797.256425254074, 3468.1849765305133, 3784.751032159381, 3941.2117576484816, 4053.43251944728, 4059.3707975263587, 5573.972130139364, 6198.4731297839735, 6421.229452465687, 6422.967885160591, 6451.161349024596, 5266.499682530153, 5424.538914192299, 5425.782968681248, 5428.37573679028, 5445.918311225335, 6592.703328350236, 6753.189617245913, 6874.175098988104, 6882.655867206619, 6898.965505172492, 3816.656500914903, 4532.977335113336, 4553.590176884097, 4559.065391594715, 4564.315352697089, 7294.197638259787, 7388.335049845486, 7396.556206627566, 7396.630168491554, 7403.888941665879, 4427.114577084596, 4576.153411618861, 4591.334256532784, 4607.631389488833, 4615.26155815068, 4651.325557794101, 4669.995950870579, 4673.929891051637, 4685.906281874343, 4696.0, 5537.640053396516, 5544.63959842609, 5548.223248745179, 5554.055810512223, 5555.333359996826, 6720.0, 7013.333733295329, 7020.613866237406, 7025.086738723933, 7035.894461583081, 1602.1268408717276, 1625.268629116902, 1630.5515983104503, 1632.0941877258235, 1632.5020868635181, 1000.4997501249376, 1036.9377837329785, 1037.2479952034864, 1055.519738518972, 1063.9521221545049, 5464.699441530754, 5691.345495268014, 6524.836879077966, 6572.704228309737, 6593.571417857824, 7254.528455650366, 7259.745908893164, 7277.0, 7281.817954551178, 7283.417326613858, 6336.239651241881, 6532.640704761284, 6545.247296560957, 6545.280019197884, 6552.9344706553275, 3708.647678470541, 3863.092173339263, 3889.6499315061214, 3893.3186692328727, 3895.902602434962, 6422.325655806167, 7414.666340014713, 7478.06524184477, 7481.513701609378, 7630.961845190738, 7475.775726728207, 7512.661930213154, 7521.962390188014, 7536.7362142324755, 7543.434242431839, 6847.897281540781, 7286.380657644054, 7625.733099341496, 7675.846483070307, 7704.499207551491, 7297.817554561178, 7300.306470885257, 7301.707931682673, 7302.2697730226555, 7305.415566754753, 7233.240509746401, 7233.240509746612, 7237.3486386223385, 7247.710091596277, 7257.201707812031, 7368.557886526825, 7674.53952762836, 7685.38516918634, 7686.269804368576, 7696.538207707556, 4160.398246674991, 4581.977090114528, 4626.583607475343, 4638.582527572535, 4641.721496710208, 6601.174853143357, 7254.927450725425, 7260.4554658399775, 7278.272172782679, 7296.452766042462, 5238.528532432099, 5250.632455728062, 7073.752418665322, 7085.787426377217, 7087.61018144007, 5767.221425107557, 6001.489873360813, 6933.4106600939485, 7088.0, 7095.858082838417, 5804.796832110856, 6635.137432133792, 6808.9659551701925, 6880.65596720172, 6905.274946130584, 7075.82310442243, 7077.363037326665, 7083.291670832876, 7099.538529995534, 7103.928960710534, 6963.40811031068, 6971.198312194163, 6976.127984002, 6991.440684745106, 6999.12510936133], "unit": "score", "name": "prototype.html", "value": 5051.618377114364}, {"lowerIsBetter": false, "replicates": [680.3196803196803, 717.9748708795194, 736.5249414127887, 741.729268816882, 745.9925400745991, 14648.0, 14765.409383624643, 14821.110733355992, 14823.258837058158, 14848.777268340984, 12684.365781710902, 12734.55429059983, 15222.847771522309, 15459.99510031847, 15561.221938903038, 705.3757424679145, 862.219691179482, 879.5646155153208, 881.0176653031888, 884.5621417398397, 719.5538765965109, 723.634564544904, 873.1748497669705, 893.7184786792172, 896.865470179475, 920.9815803683922, 933.7712260496188, 935.714607044851, 936.063936063936, 937.9906200937971, 740.7481456304882, 750.1935419424086, 934.364632050209, 939.2251392601097, 941.8116376724648, 558.9217509548625, 558.9692566908818, 682.4131247127466, 689.0766373060123, 691.8962155676638, 14982.700345993127, 15003.549893503212, 15008.849911500854, 15011.324490397958, 15028.09831410108, 12400.75198496025, 12492.0, 12614.74770504594, 12779.29713865737, 13060.0, 9934.254930880214, 9982.351147175483, 9984.45085520296, 9987.950060249725, 10011.299209055369, 3532.6643968822923, 3559.60844307126, 3564.3049605326974, 3567.1973805893467, 3572.071261472036, 80372.59813700953, 81179.0, 81911.0, 82139.17860821435, 82253.58873205655, 9533.236351274898, 9647.951760241294, 9723.367981081206, 9835.901640983499, 10199.18406527476, 21537.676934845676, 21561.784382155976, 21640.134394624354, 22099.558008839733, 22144.0, 7665.156832748393, 7696.4227682924, 7751.224877512203, 7764.145943946161, 8024.679012839538, 4108.753474791522, 4146.5853414658895, 4173.269677806433, 4181.080162364275, 4189.685773566995, 3472.461768425898, 3510.9122271943406, 3516.191276006533, 3516.2791627716256, 3517.7009954153673, 640.69887153038, 648.6821457485798, 652.3346186889346, 675.993240067593, 677.7221339250883, 537.6370949609077, 560.2129008742723, 596.7016491754123, 612.3967891626833, 621.7140115546808, 7982.481138725964, 8516.659333626585, 8671.699245113157, 8719.866417365702, 9434.954268595146, 518.085578953148, 538.3943064052941, 596.9194158788595, 627.7489004398277, 632.3076231526471, 3936.2127574485216, 3959.584243654375, 3986.7807270600397, 4021.2158629067635, 4123.958760412417, 91504.62743058859, 92587.53706231425, 95036.52481737547, 95528.0, 95531.08937821204, 79722.0, 80254.59872700598, 80393.19606803975, 80401.0, 80990.0, 68942.9658555122, 68949.0, 70338.0, 70641.0551261417, 71553.92669109968, 8169.754907352789, 8223.917760822314, 8338.666453341799, 8435.83128337442, 8500.70247541333, 50628.74685626548, 51885.48114518807, 54481.72759136179, 54514.72742636262, 54902.0, 72573.0, 72613.0, 73457.898131527, 75555.62222189074, 75633.24366756262, 11371.31772093677, 11490.88509114898, 11708.88291117078, 11712.0, 12330.753384932072, 11985.22096063753, 12156.878431215575, 12214.08394370408, 12233.449494772934, 12459.813102803284, 11372.601958931398, 11781.882181178078, 11963.401829908296, 11986.880131198577, 12059.638210853689, 11649.650510484698, 11710.297382157098, 11940.0, 11949.283043017447, 11970.341631210018, 9259.453650246236, 10096.223538526963, 11223.4388280584, 11389.316641001566, 12106.152569320415, 9207.217386522221, 9516.19112375456, 9689.12797848197, 9750.951245243728, 9943.204543636637, 8395.286400655768, 9832.852507212541, 10055.0, 10076.445795481319, 10151.035651613085], "unit": "score", "name": "yui.html", "value": 6946.53517134996}], "name": "dromaeo_css", "value": 7394.66750429971}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 110.0, 110.0, 109.0, 114.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [156.0, 123.0, 144.0, 158.0, 121.0, 141.0, 139.0, 116.0, 158.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 139.6}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 185.0, 187.0, 185.0, 186.0, 185.0, 185.0, 181.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.5}, {"lowerIsBetter": true, "replicates": [79.0, 73.0, 82.0, 77.0, 57.0, 58.0, 57.0, 80.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 125.0, 79.0, 81.0, 80.0, 133.0, 104.0, 109.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 104.3}, {"lowerIsBetter": true, "replicates": [83.0, 89.0, 83.0, 89.0, 83.0, 89.0, 84.0, 89.0, 83.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.0}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 94.0, 92.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.8}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 87.0, 84.0, 86.0, 87.0, 86.0, 87.0, 87.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 53.0, 52.0, 53.0, 53.0, 63.0, 51.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [62.0, 70.0, 71.0, 74.0, 67.0, 67.0, 64.0, 64.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 82.0, 82.0, 82.0, 89.0, 102.0, 100.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [129.0, 124.0, 129.0, 125.0, 119.0, 122.0, 124.0, 118.0, 120.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [160.0, 129.0, 136.0, 134.0, 137.0, 125.0, 136.0, 137.0, 136.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 65.0, 67.0, 66.0, 67.0, 65.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1406.7}]} 14:41:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1406.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7394.67"}}} 14:41:15 INFO - Return code: 0 14:41:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:41:15 INFO - # TBPL SUCCESS # 14:41:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:41:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:41:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:41:15 INFO - 2016-02-10 14:41:15.756 screenresolution[1687:9956] starting screenresolution argv=screenresolution get 14:41:15 INFO - 2016-02-10 14:41:15.759 screenresolution[1687:9956] Display 0: 1600x1200x32@60 14:41:15 INFO - 2016-02-10 14:41:15.765 screenresolution[1688:9960] starting screenresolution argv=screenresolution list 14:41:15 INFO - Available Modes on Display 0 14:41:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:41:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:41:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:41:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:41:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:41:16 INFO - Intel Iris: 14:41:16 INFO - Chipset Model: Intel Iris 14:41:16 INFO - Type: GPU 14:41:16 INFO - Bus: Built-In 14:41:16 INFO - VRAM (Dynamic, Max): 1536 MB 14:41:16 INFO - Vendor: Intel (0x8086) 14:41:16 INFO - Device ID: 0x0a2e 14:41:16 INFO - Revision ID: 0x0009 14:41:16 INFO - Displays: 14:41:16 INFO - Display: 14:41:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:41:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:41:16 INFO - Display Serial Number: 1600x1200 60 14:41:16 INFO - Main Display: Yes 14:41:16 INFO - Mirror: Off 14:41:16 INFO - Online: Yes 14:41:16 INFO - Rotation: Supported 14:41:16 INFO - Return code: 0 14:41:16 INFO - Running post-action listener: _resource_record_post_action 14:41:16 INFO - Running post-run listener: _resource_record_post_run 14:41:17 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39126528; Write bytes: 712847360; Read time: 421; Write time: 1972 14:41:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384580096; Write bytes: 382901760; Read time: 28444; Write time: 765 14:41:17 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38172160; Write bytes: 302498304; Read time: 406; Write time: 1156 14:41:17 INFO - Running post-run listener: _upload_blobber_files 14:41:17 INFO - Blob upload gear active. 14:41:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:41:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:41:17 INFO - (blobuploader) - INFO - Open directory for files ... 14:41:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:41:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:18 INFO - (blobuploader) - INFO - Done attempting. 14:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:41:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:19 INFO - (blobuploader) - INFO - Done attempting. 14:41:19 INFO - (blobuploader) - INFO - Iteration through files over. 14:41:19 INFO - Return code: 0 14:41:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:41:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:41:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd207a5b6d3e9cda1cb1e71f56a71c4764e762d35c3293ae3cf4d613d857f4fd50053c33b47a26f03ef19205623744aba9a9d49f17b3d6d719c5af8d0d602f72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/215535d8de6e4defd43b6de86686417b55fae3e3e621f59edfc046620e479851ae80d0a7de3f20f8019655aaae59e2e9cb38a3d5f5f349a809f276c91f1d5018"} 14:41:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:41:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:41:19 INFO - Contents: 14:41:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd207a5b6d3e9cda1cb1e71f56a71c4764e762d35c3293ae3cf4d613d857f4fd50053c33b47a26f03ef19205623744aba9a9d49f17b3d6d719c5af8d0d602f72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/215535d8de6e4defd43b6de86686417b55fae3e3e621f59edfc046620e479851ae80d0a7de3f20f8019655aaae59e2e9cb38a3d5f5f349a809f276c91f1d5018"} 14:41:19 INFO - Running post-run listener: copy_logs_to_upload_dir 14:41:19 INFO - Copying logs to upload dir... 14:41:19 INFO - mkdir: /builds/slave/test/build/upload/logs 14:41:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.638477 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-10 14:41:19.788224) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 14:41:19.791909) ========= 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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd207a5b6d3e9cda1cb1e71f56a71c4764e762d35c3293ae3cf4d613d857f4fd50053c33b47a26f03ef19205623744aba9a9d49f17b3d6d719c5af8d0d602f72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/215535d8de6e4defd43b6de86686417b55fae3e3e621f59edfc046620e479851ae80d0a7de3f20f8019655aaae59e2e9cb38a3d5f5f349a809f276c91f1d5018"} build_url:https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/QZDziNAiScKKj0hIWit9gA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd207a5b6d3e9cda1cb1e71f56a71c4764e762d35c3293ae3cf4d613d857f4fd50053c33b47a26f03ef19205623744aba9a9d49f17b3d6d719c5af8d0d602f72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/215535d8de6e4defd43b6de86686417b55fae3e3e621f59edfc046620e479851ae80d0a7de3f20f8019655aaae59e2e9cb38a3d5f5f349a809f276c91f1d5018"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 14:41:19.889061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:41:19.889384) ========= 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.w96PJMmuDE/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.1Yv4GDr9qB/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005323 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:41:19.939098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 14:41:19.939419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 14:41:19.939871) ========= ========= Total master_lag: 0.37 =========